[ 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 427326823 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.003168] x2apic enabled [ 0.004006] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.008369] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009017] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010010] pid_max: default: 32768 minimum: 301 [ 0.011120] LSM: Security Framework initializing [ 0.012049] Yama: becoming mindful. [ 0.013030] SELinux: Initializing. [ 0.014070] *** VALIDATE selinux *** [ 0.022538] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027266] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029027] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030102] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031102] *** VALIDATE tmpfs *** [ 0.032486] *** VALIDATE proc *** [ 0.033233] *** VALIDATE cgroup *** [ 0.034010] *** VALIDATE cgroup2 *** [ 0.035258] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036144] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038027] Spectre V2 : User space: Vulnerable [ 0.039009] Speculative Store Bypass: Vulnerable [ 0.042094] debug: unmapping init [mem 0xffffffffb9e59000-0xffffffffb9e60fff] [ 0.044251] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.045572] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.046022] ... version: 2 [ 0.047015] ... bit width: 48 [ 0.048012] ... generic registers: 4 [ 0.049011] ... value mask: 0000ffffffffffff [ 0.050014] ... max period: 00007fffffffffff [ 0.051013] ... fixed-purpose events: 3 [ 0.052010] ... event mask: 000000070000000f [ 0.053301] rcu: Hierarchical SRCU implementation. [ 0.055549] smp: Bringing up secondary CPUs ... [ 0.056590] x86: Booting SMP configuration: [ 0.057023] .... node #0, CPUs: #1 #2 #3 [ 0.061010] smp: Brought up 1 node, 4 CPUs [ 0.063013] smpboot: Max logical packages: 1 [ 0.064012] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.139828] node 0 deferred pages initialised in 73ms [ 0.143091] devtmpfs: initialized [ 0.144259] x86/mm: Memory block size: 128MB [ 0.147666] gcov: version magic: 0x41383552 [ 0.149184] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.152090] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.154250] pinctrl core: initialized pinctrl subsystem [ 0.155160] [ 0.155597] ************************************************************* [ 0.158010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.160008] ** ** [ 0.161009] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.164010] ** ** [ 0.165008] ** This means that this kernel is built to expose internal ** [ 0.168010] ** IOMMU data structures, which may compromise security on ** [ 0.169009] ** your system. ** [ 0.171060] ** ** [ 0.173009] ** If you see this message and you are not debugging the ** [ 0.174008] ** kernel, report this immediately to your vendor! ** [ 0.176010] ** ** [ 0.178008] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.180009] ************************************************************* [ 0.182544] NET: Registered protocol family 16 [ 0.184419] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.186047] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.188041] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.192038] cpuidle: using governor menu [ 0.193982] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.196430] PCI: Using configuration type 1 for base access [ 0.198134] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.207105] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.209027] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.213125] cryptd: max_cpu_qlen set to 1000 [ 0.217207] ACPI: Added _OSI(Module Device) [ 0.218021] ACPI: Added _OSI(Processor Device) [ 0.221017] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.223011] ACPI: Added _OSI(Processor Aggregator Device) [ 0.228208] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.233600] ACPI: Interpreter enabled [ 0.235055] ACPI: PM: (supports S0 S3 S4 S5) [ 0.237012] ACPI: Using IOAPIC for interrupt routing [ 0.239078] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.242370] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.254209] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.256037] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.259020] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.263092] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.269460] acpiphp: Slot [2] registered [ 0.271163] acpiphp: Slot [5] registered [ 0.272110] acpiphp: Slot [6] registered [ 0.274107] acpiphp: Slot [3] registered [ 0.276090] acpiphp: Slot [4] registered [ 0.277109] acpiphp: Slot [7] registered [ 0.278075] acpiphp: Slot [8] registered [ 0.280094] acpiphp: Slot [9] registered [ 0.281088] acpiphp: Slot [10] registered [ 0.283099] acpiphp: Slot [11] registered [ 0.284089] acpiphp: Slot [12] registered [ 0.286108] acpiphp: Slot [13] registered [ 0.287162] acpiphp: Slot [14] registered [ 0.289085] acpiphp: Slot [15] registered [ 0.290097] acpiphp: Slot [16] registered [ 0.292111] acpiphp: Slot [17] registered [ 0.293099] acpiphp: Slot [18] registered [ 0.295102] acpiphp: Slot [19] registered [ 0.296095] acpiphp: Slot [20] registered [ 0.298079] acpiphp: Slot [21] registered [ 0.299103] acpiphp: Slot [22] registered [ 0.301102] acpiphp: Slot [23] registered [ 0.302083] acpiphp: Slot [24] registered [ 0.303100] acpiphp: Slot [25] registered [ 0.305203] acpiphp: Slot [26] registered [ 0.307100] acpiphp: Slot [27] registered [ 0.308109] acpiphp: Slot [28] registered [ 0.310107] acpiphp: Slot [29] registered [ 0.312124] acpiphp: Slot [30] registered [ 0.313074] acpiphp: Slot [31] registered [ 0.314171] PCI host bridge to bus 0000:00 [ 0.315021] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.318024] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.320022] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.324035] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.326025] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.330046] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.332206] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.335227] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.339438] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.348021] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.352186] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.355026] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.358042] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.361027] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.364573] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.367779] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.369039] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.371921] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.375989] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.384871] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.388012] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.392429] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.397019] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.402014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.412880] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.421201] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.432021] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.438015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.450015] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.458936] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.461355] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.463430] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.468443] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.473301] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.481064] iommu: Default domain type: Passthrough [ 0.483425] SCSI subsystem initialized [ 0.485159] ACPI: bus type USB registered [ 0.486140] usbcore: registered new interface driver usbfs [ 0.488081] usbcore: registered new interface driver hub [ 0.490122] usbcore: registered new device driver usb [ 0.492181] pps_core: LinuxPPS API ver. 1 registered [ 0.494010] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.497060] PTP clock support registered [ 0.499194] EDAC MC: Ver: 3.0.0 [ 0.501145] PCI: Using ACPI for IRQ routing [ 0.502886] NetLabel: Initializing [ 0.505012] NetLabel: domain hash size = 128 [ 0.506010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.509110] NetLabel: unlabeled traffic allowed by default [ 0.511233] vgaarb: loaded [ 0.512379] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.514019] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.523360] clocksource: Switched to clocksource kvm-clock [ 0.635050] VFS: Disk quotas dquot_6.6.0 [ 0.636543] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.638421] *** VALIDATE ramfs *** [ 0.639440] *** VALIDATE hugetlbfs *** [ 0.641513] pnp: PnP ACPI init [ 0.644228] pnp: PnP ACPI: found 6 devices [ 0.663223] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.667261] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.670420] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.673092] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.676022] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.678921] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.682343] NET: Registered protocol family 2 [ 0.686229] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.693572] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.697760] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.706242] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.710762] TCP: Hash tables configured (established 65536 bind 65536) [ 0.715476] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.719202] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.722504] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.726032] NET: Registered protocol family 1 [ 0.729181] RPC: Registered named UNIX socket transport module. [ 0.731369] RPC: Registered udp transport module. [ 0.732841] RPC: Registered tcp transport module. [ 0.735112] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.737566] NET: Registered protocol family 44 [ 0.739488] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.741773] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.744087] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.746632] PCI: CLS 0 bytes, default 64 [ 0.748379] Unpacking initramfs... [ 2.265943] debug: unmapping init [mem 0xffff8af1fcc64000-0xffff8af1fffcffff] [ 2.271922] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.274874] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.278054] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.774371] Initialise system trusted keyrings [ 2.776248] Key type blacklist registered [ 2.778275] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.790617] zbud: loaded [ 2.794563] *** VALIDATE nfs *** [ 2.795877] *** VALIDATE nfs4 *** [ 2.797515] pstore: using deflate compression [ 2.801425] Platform Keyring initialized [ 2.919331] NET: Registered protocol family 38 [ 2.920983] Key type asymmetric registered [ 2.922511] Asymmetric key parser 'x509' registered [ 2.924352] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.927498] io scheduler mq-deadline registered [ 2.931172] io scheduler kyber registered [ 2.932703] io scheduler bfq registered [ 2.934556] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.937425] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.940286] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.943137] ACPI: Power Button [PWRF] [ 2.951211] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.959461] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.973535] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.002599] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.031943] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.038761] Non-volatile memory driver v1.3 [ 3.040781] Linux agpgart interface v0.103 [ 3.069310] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 3.072253] vda: detected capacity change from 0 to 73097216 [ 3.095425] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.098706] vdb: detected capacity change from 0 to 1073741824 [ 3.104913] libphy: Fixed MDIO Bus: probed [ 3.111161] usbcore: registered new interface driver usbserial_generic [ 3.114395] usbserial: USB Serial support registered for generic [ 3.117577] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.122700] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.124412] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.126933] mousedev: PS/2 mouse device common for all mice [ 3.129490] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.131374] rtc_cmos 00:05: RTC can wake from S4 [ 3.137070] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.141325] rtc_cmos 00:05: registered as rtc0 [ 3.146407] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.148849] intel_pstate: CPU model not supported [ 3.151958] hid: raw HID events driver (C) Jiri Kosina [ 3.152586] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.153668] usbcore: registered new interface driver usbhid [ 3.157653] usbhid: USB HID core driver [ 3.158823] drop_monitor: Initializing network drop monitor service [ 3.160788] Initializing XFRM netlink socket [ 3.162580] NET: Registered protocol family 10 [ 3.165639] Segment Routing with IPv6 [ 3.166830] NET: Registered protocol family 17 [ 3.168398] mpls_gso: MPLS GSO support [ 3.176837] RAS: Correctable Errors collector initialized. [ 3.178597] AVX version of gcm_enc/dec engaged. [ 3.179871] AES CTR mode by8 optimization enabled [ 3.247653] sched_clock: Marking stable (3247587321, 0)->(4092443742, -844856421) [ 3.251780] registered taskstats version 1 [ 3.254650] Loading compiled-in X.509 certificates [ 3.257204] zswap: loaded using pool lzo/zbud [ 3.281376] Key type big_key registered [ 3.294113] Key type encrypted registered [ 3.295746] ima: No TPM chip found, activating TPM-bypass! [ 3.298196] ima: Allocated hash algorithm: sha1 [ 3.299441] ima: No architecture policies found [ 3.300908] evm: Initialising EVM extended attributes: [ 3.302519] evm: security.selinux [ 3.303629] evm: security.ima [ 3.304533] evm: security.capability [ 3.305549] evm: HMAC attrs: 0x1 [ 3.308322] rtc_cmos 00:05: setting system clock to 2026-09-10 16:29:28 UTC (1789057768) [ 3.314184] debug: unmapping init [mem 0xffffffffbae03000-0xffffffffbaffffff] [ 3.317355] debug: unmapping init [mem 0xffffffffb9b82000-0xffffffffb9e58fff] [ 3.325166] Write protecting the kernel read-only data: 28672k [ 3.328246] debug: unmapping init [mem 0xffffffffb8203000-0xffffffffb83fffff] [ 3.330479] debug: unmapping init [mem 0xffffffffb8b14000-0xffffffffb8bfffff] [ 3.360400] 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.367054] systemd[1]: Detected virtualization kvm. [ 3.368787] systemd[1]: Detected architecture x86-64. [ 3.370384] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.401297] systemd[1]: No hostname configured. [ 3.402615] systemd[1]: Set hostname to . [ 3.404203] random: systemd: uninitialized urandom read (16 bytes read) [ 3.406850] systemd[1]: Initializing machine ID from random generator. [ 3.470848] random: ln: uninitialized urandom read (6 bytes read) [ 3.572742] random: systemd: uninitialized urandom read (16 bytes read) [ 3.576663] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 3.586494] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.592402] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Slices. [ OK ] Reached target Paths. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Listening on udev Control Socket. [ OK ] Listening on Journal Socket. Starting Journal Service... [ OK ] Started Memstrack Anylazing Service. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Sockets. Starting Create Volatile Files and Directories... Starting Setup Virtual Console... Starting Apply Kernel Variables... [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.238394] device-mapper: uevent: version 1.0.3 [ 4.239830] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 5.002773] virtio_net virtio0 ens2: renamed from eth0 [ 5.065346] scsi host0: ata_piix [ 5.075728] scsi host1: ata_piix [ 5.077983] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.079967] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 7.360426] random: fast init done [ 8.730179] dracut-initqueue[585]: RTNETLINK answers: File exists [ 9.814782] random: crng init done [ 9.816195] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 10.317501] 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... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.562146] printk: systemd: 24 output lines suppressed due to ratelimiting [ 11.857899] SELinux: Disabled at runtime. [ 11.918418] 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.928222] systemd[1]: Detected virtualization kvm. [ 11.930264] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.480855] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.484586] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.491287] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.495100] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.499390] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.516557] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.523957] systemd[1]: Created slice system-sshd\x2dkeygen.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting Huge Pages File System... [ OK ] Created slice User and Session Slice. [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Listening on udev Kernel Socket. Mounting Kernel Debug File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. Mounting POSIX Message Queue File System... [ OK ] Created slice system-getty.slice. Starting Remount Root and Kernel File Systems... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Activating swap /dev/disk/by-label/SWAP... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-serial\x2dgetty.slice. Starting Apply Kernel Variables... [ OK ] Listening on initctl Compatibility Named Pipe.[ 12.653590] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Reached target RPC Port Mapper. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Stopped target Initrd File Systems. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Slices. [ 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 ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [ 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. [ 13.006405] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.375939] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.479320] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.533220] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.548465] EDAC sbridge: Ver: 1.1.2 [ 14.717620] Key type dns_resolver registered [ 15.051950] NFS: Registering the id_resolver key type [ 15.053935] Key type id_resolver registered [ 15.055810] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. Starting Hostname Service... [ 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 Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... Starting System Logging Service... [ 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 oleg606-client login: [ 61.888941] libcfs: loading out-of-tree module taints kernel. [ 61.994802] Key type ._llcrypt registered [ 62.000942] Key type .llcrypt registered [ 62.731207] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 62.747235] alg: No test for adler32 (adler32-zlib) [ 64.234966] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 64.986778] LNet: Added LNI 192.168.206.6@tcp [8/256/0/180] [ 66.721378] Key type lgssc registered [ 68.523762] Lustre: Echo OBD driver; http://www.lustre.org/ [ 73.690483] alg: No test for zstdfast (zstdfast-lustre-generic) [ 73.700367] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 125.068284] hrtimer: interrupt took 2686799 ns [ 197.801960] Lustre: Mounted lustre-client [ 202.489067] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 217.934272] Lustre: DEBUG MARKER: oleg606-client.virtnet: executing check_logdir /tmp/testlogs/ [ 222.787977] Lustre: DEBUG MARKER: oleg606-client.virtnet: executing yml_node [ 223.712589] Lustre: lustre-OST0000-osc-ffff8af2485e2000: disconnect after 23s idle [ 227.397190] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 229.799614] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 232.187485] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 233.962237] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:33:17 EDT 2026 [ 254.463912] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 255.931334] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 257.439854] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a [ 259.132592] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51c 51e 834 [ 260.573357] Lustre: DEBUG MARKER: === sanity: start setup 12:33:44 (1789058024) === [ 264.129527] Lustre: DEBUG MARKER: oleg606-client.virtnet: executing check_config_client /mnt/lustre [ 279.817939] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 291.122901] Lustre: DEBUG MARKER: === sanity: finish setup 12:34:15 (1789058055) === [ 298.037412] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:34:21 (1789058061) [ 298.557909] lustre_kcompr_30360: ***** [ 298.562166] lustre_kcompr_30360: (de)compression test on random binary data [ 298.565577] lustre_kcompr_30360: ***** [ 298.592071] lustre_kcompr_30360: compr lz4(1) in 64kB chunks took 8332 us (480 MB/s), compress ratio: 95.68 [ 298.601713] lustre_kcompr_30360: compr lz4(1) in 128kB chunks took 2048 us (1953 MB/s), compress ratio: 100.28 [ 298.619421] lustre_kcompr_30360: compr lz4(1) in 256kB chunks took 1317 us (3037 MB/s), compress ratio: 102.58 [ 298.637088] lustre_kcompr_30360: compr lz4(1) in 512kB chunks took 7353 us (543 MB/s), compress ratio: 103.86 [ 298.645719] lustre_kcompr_30360: compr lz4(1) in 1024kB chunks took 1461 us (2737 MB/s), compress ratio: 104.52 [ 298.652889] lustre_kcompr_30360: compr lz4(1) in 2048kB chunks took 1361 us (2939 MB/s), compress ratio: 105.11 [ 298.659842] lustre_kcompr_30360: compr lz4(1) in 4096kB chunks took 1343 us (2978 MB/s), compress ratio: 105.28 [ 298.672421] lustre_kcompr_30360: decompr lz4(1) took 1876 us (20 MB/s) [ 298.676770] lustre_kcompr_30360: test_comp_compress_decompress(lz4,1) ret 0 [ 298.681608] lustre_kcompr_30360: acompr lz4(1) of 128kB chunks took 83 us (1506 MB/s), compress ratio: 103.45 [ 298.687547] lustre_kcompr_30360: adecompr lz4(1) took 99 us (12 MB/s) [ 298.693794] lustre_kcompr_30360: test_acomp_compress_decompress(lz4,1) ret 0 [ 298.718893] lustre_kcompr_30360: compr lz4(4) in 64kB chunks took 3169 us (1262 MB/s), compress ratio: 81.94 [ 298.730620] lustre_kcompr_30360: compr lz4(4) in 128kB chunks took 1274 us (3139 MB/s), compress ratio: 91.19 [ 298.737743] lustre_kcompr_30360: compr lz4(4) in 256kB chunks took 1859 us (2151 MB/s), compress ratio: 97.70 [ 298.745115] lustre_kcompr_30360: compr lz4(4) in 512kB chunks took 2273 us (1759 MB/s), compress ratio: 100.51 [ 298.753847] lustre_kcompr_30360: compr lz4(4) in 1024kB chunks took 1849 us (2163 MB/s), compress ratio: 101.90 [ 298.764472] lustre_kcompr_30360: compr lz4(4) in 2048kB chunks took 2150 us (1860 MB/s), compress ratio: 103.21 [ 298.777583] lustre_kcompr_30360: compr lz4(4) in 4096kB chunks took 1131 us (3536 MB/s), compress ratio: 103.59 [ 298.803961] lustre_kcompr_30360: decompr lz4(4) took 3903 us (9 MB/s) [ 298.811304] lustre_kcompr_30360: test_comp_compress_decompress(lz4,4) ret 0 [ 298.815929] lustre_kcompr_30360: acompr lz4(4) of 128kB chunks took 89 us (1404 MB/s), compress ratio: 91.02 [ 298.825143] lustre_kcompr_30360: adecompr lz4(4) took 491 us (2 MB/s) [ 298.836850] lustre_kcompr_30360: test_acomp_compress_decompress(lz4,4) ret 0 [ 298.865182] lustre_kcompr_30360: compr lz4(9) in 64kB chunks took 4002 us (999 MB/s), compress ratio: 60.55 [ 298.878830] lustre_kcompr_30360: compr lz4(9) in 128kB chunks took 2389 us (1674 MB/s), compress ratio: 75.09 [ 298.897087] lustre_kcompr_30360: compr lz4(9) in 256kB chunks took 4616 us (866 MB/s), compress ratio: 85.53 [ 298.917060] lustre_kcompr_30360: compr lz4(9) in 512kB chunks took 6144 us (651 MB/s), compress ratio: 92.00 [ 298.929324] lustre_kcompr_30360: compr lz4(9) in 1024kB chunks took 1388 us (2881 MB/s), compress ratio: 95.47 [ 298.942310] lustre_kcompr_30360: compr lz4(9) in 2048kB chunks took 2096 us (1908 MB/s), compress ratio: 97.60 [ 298.950071] lustre_kcompr_30360: compr lz4(9) in 4096kB chunks took 1425 us (2807 MB/s), compress ratio: 98.65 [ 298.970975] lustre_kcompr_30360: decompr lz4(9) took 2152 us (18 MB/s) [ 298.976677] lustre_kcompr_30360: test_comp_compress_decompress(lz4,9) ret 0 [ 298.985343] lustre_kcompr_30360: acompr lz4(9) of 128kB chunks took 429 us (291 MB/s), compress ratio: 76.69 [ 298.992625] lustre_kcompr_30360: adecompr lz4(9) took 105 us (15 MB/s) [ 299.003970] lustre_kcompr_30360: test_acomp_compress_decompress(lz4,9) ret 0 [ 299.036982] lustre_kcompr_30360: compr lz4(15) in 64kB chunks took 3633 us (1101 MB/s), compress ratio: 29.46 [ 299.046823] lustre_kcompr_30360: compr lz4(15) in 128kB chunks took 3173 us (1260 MB/s), compress ratio: 43.61 [ 299.053893] lustre_kcompr_30360: compr lz4(15) in 256kB chunks took 1983 us (2017 MB/s), compress ratio: 59.27 [ 299.062110] lustre_kcompr_30360: compr lz4(15) in 512kB chunks took 1957 us (2043 MB/s), compress ratio: 71.86 [ 299.068863] lustre_kcompr_30360: compr lz4(15) in 1024kB chunks took 1865 us (2144 MB/s), compress ratio: 78.89 [ 299.078180] lustre_kcompr_30360: compr lz4(15) in 2048kB chunks took 2248 us (1779 MB/s), compress ratio: 82.66 [ 299.086655] lustre_kcompr_30360: compr lz4(15) in 4096kB chunks took 1857 us (2154 MB/s), compress ratio: 86.20 [ 299.107513] lustre_kcompr_30360: decompr lz4(15) took 3367 us (13 MB/s) [ 299.112214] lustre_kcompr_30360: test_comp_compress_decompress(lz4,15) ret 0 [ 299.119289] lustre_kcompr_30360: acompr lz4(15) of 128kB chunks took 87 us (1436 MB/s), compress ratio: 43.44 [ 299.124228] lustre_kcompr_30360: adecompr lz4(15) took 96 us (29 MB/s) [ 299.128926] lustre_kcompr_30360: test_acomp_compress_decompress(lz4,15) ret 0 [ 299.169301] lustre_kcompr_30360: compr lz4hc(1) in 64kB chunks took 31307 us (127 MB/s), compress ratio: 95.93 [ 299.227325] lustre_kcompr_30360: compr lz4hc(1) in 128kB chunks took 51017 us (78 MB/s), compress ratio: 101.67 [ 299.259157] lustre_kcompr_30360: compr lz4hc(1) in 256kB chunks took 25930 us (154 MB/s), compress ratio: 104.80 [ 299.285840] lustre_kcompr_30360: compr lz4hc(1) in 512kB chunks took 22010 us (181 MB/s), compress ratio: 106.44 [ 299.316762] lustre_kcompr_30360: compr lz4hc(1) in 1024kB chunks took 27023 us (148 MB/s), compress ratio: 107.28 [ 299.358131] lustre_kcompr_30360: compr lz4hc(1) in 2048kB chunks took 35599 us (112 MB/s), compress ratio: 107.70 [ 299.413487] lustre_kcompr_30360: compr lz4hc(1) in 4096kB chunks took 44196 us (90 MB/s), compress ratio: 107.91 [ 299.429891] lustre_kcompr_30360: decompr lz4hc(1) took 2463 us (15 MB/s) [ 299.436825] lustre_kcompr_30360: test_comp_compress_decompress(lz4hc,1) ret 0 [ 299.445093] lustre_kcompr_30360: acompr lz4hc(1) of 128kB chunks took 584 us (214 MB/s), compress ratio: 107.70 [ 299.456447] lustre_kcompr_30360: adecompr lz4hc(1) took 80 us (14 MB/s) [ 299.471720] lustre_kcompr_30360: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 299.529368] lustre_kcompr_30360: compr lz4hc(3) in 64kB chunks took 39368 us (101 MB/s), compress ratio: 96.50 [ 299.572181] lustre_kcompr_30360: compr lz4hc(3) in 128kB chunks took 38412 us (104 MB/s), compress ratio: 102.24 [ 299.614500] lustre_kcompr_30360: compr lz4hc(3) in 256kB chunks took 37778 us (105 MB/s), compress ratio: 105.40 [ 299.657333] lustre_kcompr_30360: compr lz4hc(3) in 512kB chunks took 35955 us (111 MB/s), compress ratio: 107.06 [ 299.712684] lustre_kcompr_30360: compr lz4hc(3) in 1024kB chunks took 49986 us (80 MB/s), compress ratio: 107.89 [ 299.763626] lustre_kcompr_30360: compr lz4hc(3) in 2048kB chunks took 44059 us (90 MB/s), compress ratio: 108.32 [ 299.815731] lustre_kcompr_30360: compr lz4hc(3) in 4096kB chunks took 47489 us (84 MB/s), compress ratio: 108.54 [ 299.830358] lustre_kcompr_30360: decompr lz4hc(3) took 1454 us (25 MB/s) [ 299.835870] lustre_kcompr_30360: test_comp_compress_decompress(lz4hc,3) ret 0 [ 299.841816] lustre_kcompr_30360: acompr lz4hc(3) of 128kB chunks took 1933 us (64 MB/s), compress ratio: 107.96 [ 299.847129] lustre_kcompr_30360: adecompr lz4hc(3) took 80 us (14 MB/s) [ 299.852097] lustre_kcompr_30360: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 300.494707] lustre_kcompr_30360: compr lz4hc(8) in 64kB chunks took 634251 us (6 MB/s), compress ratio: 103.00 [ 301.213769] lustre_kcompr_30360: compr lz4hc(8) in 128kB chunks took 711343 us (5 MB/s), compress ratio: 109.81 [ 302.065643] lustre_kcompr_30360: compr lz4hc(8) in 256kB chunks took 845844 us (4 MB/s), compress ratio: 113.64 [ 303.052293] lustre_kcompr_30360: compr lz4hc(8) in 512kB chunks took 978916 us (4 MB/s), compress ratio: 115.60 [ 303.939657] lustre_kcompr_30360: compr lz4hc(8) in 1024kB chunks took 877897 us (4 MB/s), compress ratio: 116.60 [ 304.720911] lustre_kcompr_30360: compr lz4hc(8) in 2048kB chunks took 769263 us (5 MB/s), compress ratio: 117.18 [ 305.562033] lustre_kcompr_30360: compr lz4hc(8) in 4096kB chunks took 834755 us (4 MB/s), compress ratio: 117.43 [ 305.576378] lustre_kcompr_30360: decompr lz4hc(8) took 1864 us (18 MB/s) [ 305.584981] lustre_kcompr_30360: test_comp_compress_decompress(lz4hc,8) ret 0 [ 305.619091] lustre_kcompr_30360: acompr lz4hc(8) of 128kB chunks took 27454 us (4 MB/s), compress ratio: 115.58 [ 305.628854] lustre_kcompr_30360: adecompr lz4hc(8) took 263 us (4 MB/s) [ 305.645252] lustre_kcompr_30360: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 306.723699] lustre_kcompr_30360: compr lz4hc(15) in 64kB chunks took 1063899 us (3 MB/s), compress ratio: 103.42 [ 307.825542] lustre_kcompr_30360: compr lz4hc(15) in 128kB chunks took 1096280 us (3 MB/s), compress ratio: 110.79 [ 309.060619] lustre_kcompr_30360: compr lz4hc(15) in 256kB chunks took 1228281 us (3 MB/s), compress ratio: 114.87 [ 310.359640] lustre_kcompr_30360: compr lz4hc(15) in 512kB chunks took 1293946 us (3 MB/s), compress ratio: 117.00 [ 311.863938] lustre_kcompr_30360: compr lz4hc(15) in 1024kB chunks took 1487977 us (2 MB/s), compress ratio: 118.07 [ 313.482213] lustre_kcompr_30360: compr lz4hc(15) in 2048kB chunks took 1606950 us (2 MB/s), compress ratio: 118.69 [ 314.967114] lustre_kcompr_30360: compr lz4hc(15) in 4096kB chunks took 1478666 us (2 MB/s), compress ratio: 118.98 [ 314.983600] lustre_kcompr_30360: decompr lz4hc(15) took 2684 us (12 MB/s) [ 314.989043] lustre_kcompr_30360: test_comp_compress_decompress(lz4hc,15) ret 0 [ 315.031631] lustre_kcompr_30360: acompr lz4hc(15) of 128kB chunks took 37822 us (3 MB/s), compress ratio: 116.81 [ 315.043926] lustre_kcompr_30360: adecompr lz4hc(15) took 409 us (2 MB/s) [ 315.088985] lustre_kcompr_30360: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 315.103454] lustre_kcompr_30360: compr lzo(-1) in 64kB chunks took 3917 us (1021 MB/s), compress ratio: 80.85 [ 315.123801] lustre_kcompr_30360: compr lzo(-1) in 128kB chunks took 6452 us (619 MB/s), compress ratio: 85.79 [ 315.138988] lustre_kcompr_30360: compr lzo(-1) in 256kB chunks took 3925 us (1019 MB/s), compress ratio: 85.58 [ 315.149475] lustre_kcompr_30360: compr lzo(-1) in 512kB chunks took 3896 us (1026 MB/s), compress ratio: 86.78 [ 315.170912] lustre_kcompr_30360: compr lzo(-1) in 1024kB chunks took 6361 us (628 MB/s), compress ratio: 86.58 [ 315.185118] lustre_kcompr_30360: compr lzo(-1) in 2048kB chunks took 8076 us (495 MB/s), compress ratio: 87.50 [ 315.206259] lustre_kcompr_30360: compr lzo(-1) in 4096kB chunks took 9339 us (428 MB/s), compress ratio: 87.46 [ 315.241481] lustre_kcompr_30360: decompr lzo(-1) took 9214 us (4 MB/s) [ 315.253867] lustre_kcompr_30360: test_comp_compress_decompress(lzo,-1) ret 0 [ 315.267450] lustre_kcompr_30360: acompr lzo(-1) of 128kB chunks took 107 us (1168 MB/s), compress ratio: 89.59 [ 315.275287] lustre_kcompr_30360: adecompr lzo(-1) took 91 us (15 MB/s) [ 315.300210] lustre_kcompr_30360: test_acomp_compress_decompress(lzo,-1) ret 0 [ 315.831164] lustre_kcompr_30360: compr deflate(1) in 64kB chunks took 501182 us (7 MB/s), compress ratio: 96.16 [ 315.871877] Lustre: lustre-OST0001-osc-ffff8af2485e2000: disconnect after 25s idle [ 315.875868] Lustre: Skipped 1 previous similar message [ 316.287679] lustre_kcompr_30360: compr deflate(1) in 128kB chunks took 448289 us (8 MB/s), compress ratio: 106.19 [ 316.782567] lustre_kcompr_30360: compr deflate(1) in 256kB chunks took 485090 us (8 MB/s), compress ratio: 112.42 [ 317.375234] lustre_kcompr_30360: compr deflate(1) in 512kB chunks took 577056 us (6 MB/s), compress ratio: 116.15 [ 317.879889] lustre_kcompr_30360: compr deflate(1) in 1024kB chunks took 490451 us (8 MB/s), compress ratio: 118.04 [ 318.256816] lustre_kcompr_30360: compr deflate(1) in 2048kB chunks took 371717 us (10 MB/s), compress ratio: 118.96 [ 318.553243] lustre_kcompr_30360: compr deflate(1) in 4096kB chunks took 287665 us (13 MB/s), compress ratio: 119.24 [ 318.575335] lustre_kcompr_30360: decompr deflate(1) took 6874 us (4 MB/s) [ 318.592632] lustre_kcompr_30360: test_comp_compress_decompress(deflate,1) ret 0 [ 318.612416] lustre_kcompr_30360: acompr deflate(1) of 128kB chunks took 12443 us (10 MB/s), compress ratio: 112.60 [ 318.619555] lustre_kcompr_30360: adecompr deflate(1) took 294 us (3 MB/s) [ 318.627204] lustre_kcompr_30360: test_acomp_compress_decompress(deflate,1) ret 0 [ 319.060964] lustre_kcompr_30360: compr deflate(6) in 64kB chunks took 417893 us (9 MB/s), compress ratio: 96.16 [ 319.493972] lustre_kcompr_30360: compr deflate(6) in 128kB chunks took 425657 us (9 MB/s), compress ratio: 106.19 [ 319.941748] lustre_kcompr_30360: compr deflate(6) in 256kB chunks took 440182 us (9 MB/s), compress ratio: 112.42 [ 320.305402] lustre_kcompr_30360: compr deflate(6) in 512kB chunks took 357664 us (11 MB/s), compress ratio: 116.15 [ 320.832856] lustre_kcompr_30360: compr deflate(6) in 1024kB chunks took 516421 us (7 MB/s), compress ratio: 118.04 [ 321.303673] lustre_kcompr_30360: compr deflate(6) in 2048kB chunks took 457857 us (8 MB/s), compress ratio: 118.96 [ 321.878799] lustre_kcompr_30360: compr deflate(6) in 4096kB chunks took 561884 us (7 MB/s), compress ratio: 119.24 [ 321.906532] lustre_kcompr_30360: decompr deflate(6) took 8940 us (3 MB/s) [ 321.921505] lustre_kcompr_30360: test_comp_compress_decompress(deflate,6) ret 0 [ 321.955171] lustre_kcompr_30360: acompr deflate(6) of 128kB chunks took 20273 us (6 MB/s), compress ratio: 112.60 [ 321.965783] lustre_kcompr_30360: adecompr deflate(6) took 163 us (6 MB/s) [ 321.975266] lustre_kcompr_30360: test_acomp_compress_decompress(deflate,6) ret 0 [ 322.477257] lustre_kcompr_30360: compr deflate(9) in 64kB chunks took 477633 us (8 MB/s), compress ratio: 96.16 [ 322.916673] lustre_kcompr_30360: compr deflate(9) in 128kB chunks took 433461 us (9 MB/s), compress ratio: 106.19 [ 323.348618] lustre_kcompr_30360: compr deflate(9) in 256kB chunks took 420180 us (9 MB/s), compress ratio: 112.42 [ 323.942370] lustre_kcompr_30360: compr deflate(9) in 512kB chunks took 587219 us (6 MB/s), compress ratio: 116.15 [ 324.502641] lustre_kcompr_30360: compr deflate(9) in 1024kB chunks took 552426 us (7 MB/s), compress ratio: 118.04 [ 324.779844] lustre_kcompr_30360: compr deflate(9) in 2048kB chunks took 269640 us (14 MB/s), compress ratio: 118.96 [ 325.196496] lustre_kcompr_30360: compr deflate(9) in 4096kB chunks took 409578 us (9 MB/s), compress ratio: 119.24 [ 325.223558] lustre_kcompr_30360: decompr deflate(9) took 10086 us (3 MB/s) [ 325.229845] lustre_kcompr_30360: test_comp_compress_decompress(deflate,9) ret 0 [ 325.248540] lustre_kcompr_30360: acompr deflate(9) of 128kB chunks took 11259 us (11 MB/s), compress ratio: 112.60 [ 325.253954] lustre_kcompr_30360: adecompr deflate(9) took 182 us (6 MB/s) [ 325.262939] lustre_kcompr_30360: test_acomp_compress_decompress(deflate,9) ret 0 [ 325.295715] lustre_kcompr_30360: compr zstd(0) in 64kB chunks took 12537 us (319 MB/s), compress ratio: 155.33 [ 325.328992] lustre_kcompr_30360: compr zstd(0) in 128kB chunks took 26097 us (153 MB/s), compress ratio: 187.37 [ 325.359685] lustre_kcompr_30360: compr zstd(0) in 256kB chunks took 23294 us (171 MB/s), compress ratio: 199.34 [ 325.398625] lustre_kcompr_30360: compr zstd(0) in 512kB chunks took 32757 us (122 MB/s), compress ratio: 206.16 [ 325.413892] lustre_kcompr_30360: compr zstd(0) in 1024kB chunks took 5827 us (686 MB/s), compress ratio: 208.85 [ 325.433855] lustre_kcompr_30360: compr zstd(0) in 2048kB chunks took 6299 us (635 MB/s), compress ratio: 209.21 [ 325.443493] lustre_kcompr_30360: compr zstd(0) in 4096kB chunks took 3358 us (1191 MB/s), compress ratio: 210.79 [ 325.465550] lustre_kcompr_30360: decompr zstd(0) took 3886 us (4 MB/s) [ 325.473803] lustre_kcompr_30360: test_comp_compress_decompress(zstd,0) ret 0 [ 325.491477] lustre_kcompr_30360: acompr zstd(0) of 128kB chunks took 1184 us (105 MB/s), compress ratio: 202.58 [ 325.501116] lustre_kcompr_30360: adecompr zstd(0) took 1328 us (0 MB/s) [ 325.516594] lustre_kcompr_30360: test_acomp_compress_decompress(zstd,0) ret 0 [ 325.548937] lustre_kcompr_30360: compr zstd(1) in 64kB chunks took 8018 us (498 MB/s), compress ratio: 154.44 [ 325.565749] lustre_kcompr_30360: compr zstd(1) in 128kB chunks took 3177 us (1259 MB/s), compress ratio: 185.90 [ 325.576224] lustre_kcompr_30360: compr zstd(1) in 256kB chunks took 3239 us (1234 MB/s), compress ratio: 197.12 [ 325.590827] lustre_kcompr_30360: compr zstd(1) in 512kB chunks took 5586 us (716 MB/s), compress ratio: 202.77 [ 325.608146] lustre_kcompr_30360: compr zstd(1) in 1024kB chunks took 2260 us (1769 MB/s), compress ratio: 205.61 [ 325.620166] lustre_kcompr_30360: compr zstd(1) in 2048kB chunks took 4646 us (860 MB/s), compress ratio: 207.01 [ 325.629959] lustre_kcompr_30360: compr zstd(1) in 4096kB chunks took 2022 us (1978 MB/s), compress ratio: 207.54 [ 325.649629] lustre_kcompr_30360: decompr zstd(1) took 1774 us (10 MB/s) [ 325.659472] lustre_kcompr_30360: test_comp_compress_decompress(zstd,1) ret 0 [ 325.671065] lustre_kcompr_30360: acompr zstd(1) of 128kB chunks took 408 us (306 MB/s), compress ratio: 202.58 [ 325.683036] lustre_kcompr_30360: adecompr zstd(1) took 95 us (6 MB/s) [ 325.695508] lustre_kcompr_30360: test_acomp_compress_decompress(zstd,1) ret 0 [ 325.984821] lustre_kcompr_30360: compr zstd(10) in 64kB chunks took 257294 us (15 MB/s), compress ratio: 157.66 [ 326.226467] lustre_kcompr_30360: compr zstd(10) in 128kB chunks took 233605 us (17 MB/s), compress ratio: 179.21 [ 326.490961] lustre_kcompr_30360: compr zstd(10) in 256kB chunks took 245610 us (16 MB/s), compress ratio: 190.03 [ 326.667578] lustre_kcompr_30360: compr zstd(10) in 512kB chunks took 170890 us (23 MB/s), compress ratio: 210.38 [ 326.979115] lustre_kcompr_30360: compr zstd(10) in 1024kB chunks took 301856 us (13 MB/s), compress ratio: 214.48 [ 327.452898] lustre_kcompr_30360: compr zstd(10) in 2048kB chunks took 468008 us (8 MB/s), compress ratio: 216.62 [ 327.571497] lustre_kcompr_30360: compr zstd(10) in 4096kB chunks took 102975 us (38 MB/s), compress ratio: 217.17 [ 327.609957] lustre_kcompr_30360: decompr zstd(10) took 4819 us (3 MB/s) [ 327.625109] lustre_kcompr_30360: test_comp_compress_decompress(zstd,10) ret 0 [ 327.645857] lustre_kcompr_30360: acompr zstd(10) of 128kB chunks took 9880 us (12 MB/s), compress ratio: 193.32 [ 327.655599] lustre_kcompr_30360: adecompr zstd(10) took 411 us (1 MB/s) [ 327.666638] lustre_kcompr_30360: test_acomp_compress_decompress(zstd,10) ret 0 [ 328.526993] lustre_kcompr_30360: compr zstd(15) in 64kB chunks took 830889 us (4 MB/s), compress ratio: 165.88 [ 329.767545] lustre_kcompr_30360: compr zstd(15) in 128kB chunks took 1226697 us (3 MB/s), compress ratio: 189.95 [ 330.584829] lustre_kcompr_30360: compr zstd(15) in 256kB chunks took 804230 us (4 MB/s), compress ratio: 202.50 [ 331.376823] lustre_kcompr_30360: compr zstd(15) in 512kB chunks took 770029 us (5 MB/s), compress ratio: 210.56 [ 332.058967] lustre_kcompr_30360: compr zstd(15) in 1024kB chunks took 673534 us (5 MB/s), compress ratio: 213.72 [ 333.371119] lustre_kcompr_30360: compr zstd(15) in 2048kB chunks took 1299887 us (3 MB/s), compress ratio: 214.43 [ 334.922396] lustre_kcompr_30360: compr zstd(15) in 4096kB chunks took 1537292 us (2 MB/s), compress ratio: 213.90 [ 334.941433] lustre_kcompr_30360: decompr zstd(15) took 2902 us (6 MB/s) [ 334.950292] lustre_kcompr_30360: test_comp_compress_decompress(zstd,15) ret 0 [ 334.996761] lustre_kcompr_30360: acompr zstd(15) of 128kB chunks took 39839 us (3 MB/s), compress ratio: 207.39 [ 335.012214] lustre_kcompr_30360: adecompr zstd(15) took 175 us (3 MB/s) [ 335.021951] lustre_kcompr_30360: test_acomp_compress_decompress(zstd,15) ret 0 [ 335.041442] lustre_kcompr_30360: compr zstdfast(1) in 64kB chunks took 4678 us (855 MB/s), compress ratio: 154.44 [ 335.052233] lustre_kcompr_30360: compr zstdfast(1) in 128kB chunks took 3424 us (1168 MB/s), compress ratio: 185.90 [ 335.064153] lustre_kcompr_30360: compr zstdfast(1) in 256kB chunks took 4297 us (930 MB/s), compress ratio: 197.12 [ 335.072386] lustre_kcompr_30360: compr zstdfast(1) in 512kB chunks took 2185 us (1830 MB/s), compress ratio: 202.77 [ 335.082489] lustre_kcompr_30360: compr zstdfast(1) in 1024kB chunks took 2344 us (1706 MB/s), compress ratio: 205.69 [ 335.096733] lustre_kcompr_30360: compr zstdfast(1) in 2048kB chunks took 6840 us (584 MB/s), compress ratio: 207.01 [ 335.106929] lustre_kcompr_30360: compr zstdfast(1) in 4096kB chunks took 3442 us (1162 MB/s), compress ratio: 207.54 [ 335.124730] lustre_kcompr_30360: decompr zstdfast(1) took 2524 us (7 MB/s) [ 335.130414] lustre_kcompr_30360: test_comp_compress_decompress(zstdfast,1) ret 0 [ 335.134804] lustre_kcompr_30360: acompr zstdfast(1) of 128kB chunks took 1023 us (122 MB/s), compress ratio: 202.58 [ 335.141347] lustre_kcompr_30360: adecompr zstdfast(1) took 97 us (6 MB/s) [ 335.147938] lustre_kcompr_30360: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 335.164994] lustre_kcompr_30360: compr zstdfast(5) in 64kB chunks took 4084 us (979 MB/s), compress ratio: 135.71 [ 335.175761] lustre_kcompr_30360: compr zstdfast(5) in 128kB chunks took 3250 us (1230 MB/s), compress ratio: 160.54 [ 335.190200] lustre_kcompr_30360: compr zstdfast(5) in 256kB chunks took 7411 us (539 MB/s), compress ratio: 169.52 [ 335.203667] lustre_kcompr_30360: compr zstdfast(5) in 512kB chunks took 5748 us (695 MB/s), compress ratio: 174.44 [ 335.212879] lustre_kcompr_30360: compr zstdfast(5) in 1024kB chunks took 2392 us (1672 MB/s), compress ratio: 176.95 [ 335.224641] lustre_kcompr_30360: compr zstdfast(5) in 2048kB chunks took 3434 us (1164 MB/s), compress ratio: 176.99 [ 335.236376] lustre_kcompr_30360: compr zstdfast(5) in 4096kB chunks took 3858 us (1036 MB/s), compress ratio: 176.93 [ 335.253763] lustre_kcompr_30360: decompr zstdfast(5) took 2161 us (10 MB/s) [ 335.258336] lustre_kcompr_30360: test_comp_compress_decompress(zstdfast,5) ret 0 [ 335.267463] lustre_kcompr_30360: acompr zstdfast(5) of 128kB chunks took 140 us (892 MB/s), compress ratio: 178.81 [ 335.282966] lustre_kcompr_30360: adecompr zstdfast(5) took 99 us (7 MB/s) [ 335.299896] lustre_kcompr_30360: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 335.319501] lustre_kcompr_30360: compr zstdfast(12) in 64kB chunks took 5923 us (675 MB/s), compress ratio: 37.14 [ 335.329173] lustre_kcompr_30360: compr zstdfast(12) in 128kB chunks took 1778 us (2249 MB/s), compress ratio: 42.22 [ 335.340238] lustre_kcompr_30360: compr zstdfast(12) in 256kB chunks took 5652 us (707 MB/s), compress ratio: 45.46 [ 335.356439] lustre_kcompr_30360: compr zstdfast(12) in 512kB chunks took 7126 us (561 MB/s), compress ratio: 49.91 [ 335.365131] lustre_kcompr_30360: compr zstdfast(12) in 1024kB chunks took 2391 us (1672 MB/s), compress ratio: 54.07 [ 335.383165] lustre_kcompr_30360: compr zstdfast(12) in 2048kB chunks took 2669 us (1498 MB/s), compress ratio: 54.51 [ 335.406043] lustre_kcompr_30360: compr zstdfast(12) in 4096kB chunks took 2505 us (1596 MB/s), compress ratio: 64.82 [ 335.419235] lustre_kcompr_30360: decompr zstdfast(12) took 2401 us (25 MB/s) [ 335.422841] lustre_kcompr_30360: test_comp_compress_decompress(zstdfast,12) ret 0 [ 335.427235] lustre_kcompr_30360: acompr zstdfast(12) of 128kB chunks took 247 us (506 MB/s), compress ratio: 46.43 [ 335.436718] lustre_kcompr_30360: adecompr zstdfast(12) took 102 us (26 MB/s) [ 335.453569] lustre_kcompr_30360: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 335.481607] lustre_kcompr_30360: compr zstdfast(15) in 64kB chunks took 4982 us (802 MB/s), compress ratio: 18.57 [ 335.499236] lustre_kcompr_30360: compr zstdfast(15) in 128kB chunks took 4029 us (992 MB/s), compress ratio: 19.74 [ 335.511487] lustre_kcompr_30360: compr zstdfast(15) in 256kB chunks took 6484 us (616 MB/s), compress ratio: 20.70 [ 335.519718] lustre_kcompr_30360: compr zstdfast(15) in 512kB chunks took 2288 us (1748 MB/s), compress ratio: 24.90 [ 335.527453] lustre_kcompr_30360: compr zstdfast(15) in 1024kB chunks took 2004 us (1996 MB/s), compress ratio: 30.96 [ 335.541418] lustre_kcompr_30360: compr zstdfast(15) in 2048kB chunks took 2466 us (1622 MB/s), compress ratio: 33.86 [ 335.548451] lustre_kcompr_30360: compr zstdfast(15) in 4096kB chunks took 2071 us (1931 MB/s), compress ratio: 34.39 [ 335.564944] lustre_kcompr_30360: decompr zstdfast(15) took 2378 us (48 MB/s) [ 335.569698] lustre_kcompr_30360: test_comp_compress_decompress(zstdfast,15) ret 0 [ 335.574394] lustre_kcompr_30360: acompr zstdfast(15) of 128kB chunks took 148 us (844 MB/s), compress ratio: 19.08 [ 335.579675] lustre_kcompr_30360: adecompr zstdfast(15) took 104 us (62 MB/s) [ 335.586597] lustre_kcompr_30360: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 335.590589] lustre_kcompr_30360: SUCCESS [ 342.751781] lustre_kcompr_2997: ***** [ 342.753678] lustre_kcompr_2997: (de)compression test on provided file /tmp/f84.sanity [ 342.758859] lustre_kcompr_2997: ***** [ 342.830347] lustre_kcompr_2997: compr lz4(1) in 64kB chunks took 46824 us (85 MB/s), compress ratio: 2.93 [ 342.881289] lustre_kcompr_2997: compr lz4(1) in 128kB chunks took 44137 us (90 MB/s), compress ratio: 3.04 [ 342.925997] lustre_kcompr_2997: compr lz4(1) in 256kB chunks took 35021 us (114 MB/s), compress ratio: 3.08 [ 342.961865] lustre_kcompr_2997: compr lz4(1) in 512kB chunks took 31434 us (127 MB/s), compress ratio: 3.10 [ 343.002843] lustre_kcompr_2997: compr lz4(1) in 1024kB chunks took 35687 us (112 MB/s), compress ratio: 3.11 [ 343.057198] lustre_kcompr_2997: compr lz4(1) in 2048kB chunks took 41888 us (95 MB/s), compress ratio: 3.11 [ 343.086356] lustre_kcompr_2997: compr lz4(1) in 4096kB chunks took 24055 us (166 MB/s), compress ratio: 3.12 [ 343.111411] lustre_kcompr_2997: decompr lz4(1) took 8016 us (159 MB/s) [ 343.120382] lustre_kcompr_2997: test_comp_compress_decompress(lz4,1) ret 0 [ 343.129369] lustre_kcompr_2997: acompr lz4(1) of 128kB chunks took 767 us (162 MB/s), compress ratio: 2.68 [ 343.140194] lustre_kcompr_2997: adecompr lz4(1) took 213 us (218 MB/s) [ 343.147753] lustre_kcompr_2997: test_acomp_compress_decompress(lz4,1) ret 0 [ 343.197609] lustre_kcompr_2997: compr lz4(4) in 64kB chunks took 30948 us (129 MB/s), compress ratio: 2.67 [ 343.235496] lustre_kcompr_2997: compr lz4(4) in 128kB chunks took 30630 us (130 MB/s), compress ratio: 2.63 [ 343.272924] lustre_kcompr_2997: compr lz4(4) in 256kB chunks took 30570 us (130 MB/s), compress ratio: 2.68 [ 343.319394] lustre_kcompr_2997: compr lz4(4) in 512kB chunks took 38394 us (104 MB/s), compress ratio: 2.71 [ 343.369728] lustre_kcompr_2997: compr lz4(4) in 1024kB chunks took 41255 us (96 MB/s), compress ratio: 2.72 [ 343.414171] lustre_kcompr_2997: compr lz4(4) in 2048kB chunks took 34792 us (114 MB/s), compress ratio: 2.72 [ 343.466283] lustre_kcompr_2997: compr lz4(4) in 4096kB chunks took 42495 us (94 MB/s), compress ratio: 2.73 [ 343.493413] lustre_kcompr_2997: decompr lz4(4) took 14438 us (101 MB/s) [ 343.502404] lustre_kcompr_2997: test_comp_compress_decompress(lz4,4) ret 0 [ 343.513199] lustre_kcompr_2997: acompr lz4(4) of 128kB chunks took 664 us (188 MB/s), compress ratio: 2.30 [ 343.521751] lustre_kcompr_2997: adecompr lz4(4) took 728 us (74 MB/s) [ 343.552806] lustre_kcompr_2997: test_acomp_compress_decompress(lz4,4) ret 0 [ 343.643727] lustre_kcompr_2997: compr lz4(9) in 64kB chunks took 53291 us (75 MB/s), compress ratio: 2.30 [ 343.684122] lustre_kcompr_2997: compr lz4(9) in 128kB chunks took 35781 us (111 MB/s), compress ratio: 2.15 [ 343.740626] lustre_kcompr_2997: compr lz4(9) in 256kB chunks took 45932 us (87 MB/s), compress ratio: 2.20 [ 343.778280] lustre_kcompr_2997: compr lz4(9) in 512kB chunks took 29690 us (134 MB/s), compress ratio: 2.23 [ 343.813795] lustre_kcompr_2997: compr lz4(9) in 1024kB chunks took 25465 us (157 MB/s), compress ratio: 2.25 [ 343.850767] lustre_kcompr_2997: compr lz4(9) in 2048kB chunks took 30292 us (132 MB/s), compress ratio: 2.25 [ 343.884624] lustre_kcompr_2997: compr lz4(9) in 4096kB chunks took 24126 us (165 MB/s), compress ratio: 2.26 [ 343.917764] lustre_kcompr_2997: decompr lz4(9) took 14001 us (126 MB/s) [ 343.923158] lustre_kcompr_2997: test_comp_compress_decompress(lz4,9) ret 0 [ 343.928825] lustre_kcompr_2997: acompr lz4(9) of 128kB chunks took 911 us (137 MB/s), compress ratio: 1.87 [ 343.935310] lustre_kcompr_2997: adecompr lz4(9) took 286 us (233 MB/s) [ 343.947087] lustre_kcompr_2997: test_acomp_compress_decompress(lz4,9) ret 0 [ 343.977947] lustre_kcompr_2997: compr lz4(15) in 64kB chunks took 16692 us (239 MB/s), compress ratio: 1.63 [ 344.018969] lustre_kcompr_2997: compr lz4(15) in 128kB chunks took 18276 us (218 MB/s), compress ratio: 1.52 [ 344.051849] lustre_kcompr_2997: compr lz4(15) in 256kB chunks took 23103 us (173 MB/s), compress ratio: 1.56 [ 344.088984] lustre_kcompr_2997: compr lz4(15) in 512kB chunks took 21028 us (190 MB/s), compress ratio: 1.58 [ 344.113096] lustre_kcompr_2997: compr lz4(15) in 1024kB chunks took 18419 us (217 MB/s), compress ratio: 1.60 [ 344.134523] lustre_kcompr_2997: compr lz4(15) in 2048kB chunks took 11861 us (337 MB/s), compress ratio: 1.60 [ 344.156519] lustre_kcompr_2997: compr lz4(15) in 4096kB chunks took 14416 us (277 MB/s), compress ratio: 1.60 [ 344.174650] lustre_kcompr_2997: decompr lz4(15) took 5259 us (472 MB/s) [ 344.180131] lustre_kcompr_2997: test_comp_compress_decompress(lz4,15) ret 0 [ 344.186881] lustre_kcompr_2997: acompr lz4(15) of 128kB chunks took 377 us (331 MB/s), compress ratio: 1.33 [ 344.203625] lustre_kcompr_2997: adecompr lz4(15) took 505 us (186 MB/s) [ 344.210854] lustre_kcompr_2997: test_acomp_compress_decompress(lz4,15) ret 0 [ 344.442241] lustre_kcompr_2997: compr lz4hc(1) in 64kB chunks took 215831 us (18 MB/s), compress ratio: 3.58 [ 344.642402] lustre_kcompr_2997: compr lz4hc(1) in 128kB chunks took 189277 us (21 MB/s), compress ratio: 3.77 [ 344.839432] lustre_kcompr_2997: compr lz4hc(1) in 256kB chunks took 190135 us (21 MB/s), compress ratio: 3.88 [ 345.124078] lustre_kcompr_2997: compr lz4hc(1) in 512kB chunks took 278170 us (14 MB/s), compress ratio: 3.93 [ 345.379249] lustre_kcompr_2997: compr lz4hc(1) in 1024kB chunks took 247282 us (16 MB/s), compress ratio: 3.96 [ 345.625675] lustre_kcompr_2997: compr lz4hc(1) in 2048kB chunks took 241014 us (16 MB/s), compress ratio: 3.97 [ 345.864598] lustre_kcompr_2997: compr lz4hc(1) in 4096kB chunks took 230900 us (17 MB/s), compress ratio: 3.98 [ 345.884269] lustre_kcompr_2997: decompr lz4hc(1) took 5925 us (169 MB/s) [ 345.892527] lustre_kcompr_2997: test_comp_compress_decompress(lz4hc,1) ret 0 [ 345.921613] lustre_kcompr_2997: acompr lz4hc(1) of 128kB chunks took 18025 us (6 MB/s), compress ratio: 3.27 [ 345.931678] lustre_kcompr_2997: adecompr lz4hc(1) took 497 us (76 MB/s) [ 345.950190] lustre_kcompr_2997: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 346.216080] lustre_kcompr_2997: compr lz4hc(3) in 64kB chunks took 249140 us (16 MB/s), compress ratio: 3.68 [ 346.523989] lustre_kcompr_2997: compr lz4hc(3) in 128kB chunks took 303922 us (13 MB/s), compress ratio: 3.91 [ 346.833894] lustre_kcompr_2997: compr lz4hc(3) in 256kB chunks took 302378 us (13 MB/s), compress ratio: 4.04 [ 347.178491] lustre_kcompr_2997: compr lz4hc(3) in 512kB chunks took 337978 us (11 MB/s), compress ratio: 4.10 [ 347.404247] lustre_kcompr_2997: compr lz4hc(3) in 1024kB chunks took 221119 us (18 MB/s), compress ratio: 4.13 [ 347.787620] lustre_kcompr_2997: compr lz4hc(3) in 2048kB chunks took 378258 us (10 MB/s), compress ratio: 4.15 [ 348.111900] lustre_kcompr_2997: compr lz4hc(3) in 4096kB chunks took 311124 us (12 MB/s), compress ratio: 4.16 [ 348.134557] lustre_kcompr_2997: decompr lz4hc(3) took 7001 us (137 MB/s) [ 348.138890] lustre_kcompr_2997: test_comp_compress_decompress(lz4hc,3) ret 0 [ 348.148899] lustre_kcompr_2997: acompr lz4hc(3) of 128kB chunks took 4905 us (25 MB/s), compress ratio: 3.38 [ 348.155779] lustre_kcompr_2997: adecompr lz4hc(3) took 164 us (224 MB/s) [ 348.164455] lustre_kcompr_2997: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 348.650730] lustre_kcompr_2997: compr lz4hc(8) in 64kB chunks took 471076 us (8 MB/s), compress ratio: 3.72 [ 349.054146] lustre_kcompr_2997: compr lz4hc(8) in 128kB chunks took 388227 us (10 MB/s), compress ratio: 3.96 [ 349.572823] lustre_kcompr_2997: compr lz4hc(8) in 256kB chunks took 512834 us (7 MB/s), compress ratio: 4.10 [ 350.032270] lustre_kcompr_2997: compr lz4hc(8) in 512kB chunks took 454797 us (8 MB/s), compress ratio: 4.17 [ 350.534780] lustre_kcompr_2997: compr lz4hc(8) in 1024kB chunks took 496874 us (8 MB/s), compress ratio: 4.21 [ 351.136197] lustre_kcompr_2997: compr lz4hc(8) in 2048kB chunks took 595859 us (6 MB/s), compress ratio: 4.22 [ 351.679716] lustre_kcompr_2997: compr lz4hc(8) in 4096kB chunks took 532507 us (7 MB/s), compress ratio: 4.23 [ 351.699770] lustre_kcompr_2997: decompr lz4hc(8) took 6858 us (137 MB/s) [ 351.704154] lustre_kcompr_2997: test_comp_compress_decompress(lz4hc,8) ret 0 [ 351.731254] lustre_kcompr_2997: acompr lz4hc(8) of 128kB chunks took 21954 us (5 MB/s), compress ratio: 3.42 [ 351.742510] lustre_kcompr_2997: adecompr lz4hc(8) took 179 us (203 MB/s) [ 351.756901] lustre_kcompr_2997: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 352.055643] lustre_kcompr_2997: compr lz4hc(15) in 64kB chunks took 276478 us (14 MB/s), compress ratio: 3.72 [ 352.444340] lustre_kcompr_2997: compr lz4hc(15) in 128kB chunks took 380560 us (10 MB/s), compress ratio: 3.96 [ 353.019801] lustre_kcompr_2997: compr lz4hc(15) in 256kB chunks took 570448 us (7 MB/s), compress ratio: 4.10 [ 353.512422] lustre_kcompr_2997: compr lz4hc(15) in 512kB chunks took 481290 us (8 MB/s), compress ratio: 4.17 [ 354.030372] lustre_kcompr_2997: compr lz4hc(15) in 1024kB chunks took 508436 us (7 MB/s), compress ratio: 4.21 [ 354.611306] lustre_kcompr_2997: compr lz4hc(15) in 2048kB chunks took 574344 us (6 MB/s), compress ratio: 4.22 [ 355.199495] lustre_kcompr_2997: compr lz4hc(15) in 4096kB chunks took 571986 us (6 MB/s), compress ratio: 4.23 [ 355.222864] lustre_kcompr_2997: decompr lz4hc(15) took 8550 us (110 MB/s) [ 355.228356] lustre_kcompr_2997: test_comp_compress_decompress(lz4hc,15) ret 0 [ 355.260891] lustre_kcompr_2997: acompr lz4hc(15) of 128kB chunks took 24996 us (5 MB/s), compress ratio: 3.42 [ 355.268526] lustre_kcompr_2997: adecompr lz4hc(15) took 168 us (216 MB/s) [ 355.277836] lustre_kcompr_2997: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 355.313446] lustre_kcompr_2997: compr lzo(-1) in 64kB chunks took 28433 us (140 MB/s), compress ratio: 2.90 [ 355.342492] lustre_kcompr_2997: compr lzo(-1) in 128kB chunks took 24432 us (163 MB/s), compress ratio: 2.95 [ 355.365864] lustre_kcompr_2997: compr lzo(-1) in 256kB chunks took 19165 us (208 MB/s), compress ratio: 2.96 [ 355.389571] lustre_kcompr_2997: compr lzo(-1) in 512kB chunks took 17595 us (227 MB/s), compress ratio: 2.98 [ 355.412107] lustre_kcompr_2997: compr lzo(-1) in 1024kB chunks took 18868 us (211 MB/s), compress ratio: 2.97 [ 355.436946] lustre_kcompr_2997: compr lzo(-1) in 2048kB chunks took 19158 us (208 MB/s), compress ratio: 2.97 [ 355.459382] lustre_kcompr_2997: compr lzo(-1) in 4096kB chunks took 18602 us (215 MB/s), compress ratio: 2.96 [ 355.476489] lustre_kcompr_2997: decompr lzo(-1) took 8395 us (160 MB/s) [ 355.480766] lustre_kcompr_2997: test_comp_compress_decompress(lzo,-1) ret 0 [ 355.489553] lustre_kcompr_2997: acompr lzo(-1) of 128kB chunks took 702 us (178 MB/s), compress ratio: 2.62 [ 355.494437] lustre_kcompr_2997: adecompr lzo(-1) took 560 us (85 MB/s) [ 355.499038] lustre_kcompr_2997: test_acomp_compress_decompress(lzo,-1) ret 0 [ 356.143916] lustre_kcompr_2997: compr deflate(1) in 64kB chunks took 636272 us (6 MB/s), compress ratio: 3.51 [ 356.850926] lustre_kcompr_2997: compr deflate(1) in 128kB chunks took 694799 us (5 MB/s), compress ratio: 3.53 [ 357.686469] lustre_kcompr_2997: compr deflate(1) in 256kB chunks took 820154 us (4 MB/s), compress ratio: 3.53 [ 358.341889] lustre_kcompr_2997: compr deflate(1) in 512kB chunks took 649357 us (6 MB/s), compress ratio: 3.54 [ 358.817557] lustre_kcompr_2997: compr deflate(1) in 1024kB chunks took 471080 us (8 MB/s), compress ratio: 3.54 [ 359.699448] lustre_kcompr_2997: compr deflate(1) in 2048kB chunks took 875434 us (4 MB/s), compress ratio: 3.54 [ 360.475789] lustre_kcompr_2997: compr deflate(1) in 4096kB chunks took 765652 us (5 MB/s), compress ratio: 3.54 [ 360.580510] lustre_kcompr_2997: decompr deflate(1) took 82968 us (13 MB/s) [ 360.596509] lustre_kcompr_2997: test_comp_compress_decompress(deflate,1) ret 0 [ 360.631969] lustre_kcompr_2997: acompr deflate(1) of 128kB chunks took 25422 us (4 MB/s), compress ratio: 3.09 [ 360.646895] lustre_kcompr_2997: adecompr deflate(1) took 2155 us (18 MB/s) [ 360.662728] lustre_kcompr_2997: test_acomp_compress_decompress(deflate,1) ret 0 [ 361.449949] lustre_kcompr_2997: compr deflate(6) in 64kB chunks took 759246 us (5 MB/s), compress ratio: 3.51 [ 362.250598] lustre_kcompr_2997: compr deflate(6) in 128kB chunks took 787035 us (5 MB/s), compress ratio: 3.53 [ 362.930264] lustre_kcompr_2997: compr deflate(6) in 256kB chunks took 672676 us (5 MB/s), compress ratio: 3.53 [ 363.591460] lustre_kcompr_2997: compr deflate(6) in 512kB chunks took 651221 us (6 MB/s), compress ratio: 3.54 [ 364.378733] lustre_kcompr_2997: compr deflate(6) in 1024kB chunks took 776058 us (5 MB/s), compress ratio: 3.54 [ 365.200168] lustre_kcompr_2997: compr deflate(6) in 2048kB chunks took 816092 us (4 MB/s), compress ratio: 3.54 [ 365.958144] lustre_kcompr_2997: compr deflate(6) in 4096kB chunks took 751561 us (5 MB/s), compress ratio: 3.54 [ 366.036395] lustre_kcompr_2997: decompr deflate(6) took 57532 us (19 MB/s) [ 366.044362] lustre_kcompr_2997: test_comp_compress_decompress(deflate,6) ret 0 [ 366.089670] lustre_kcompr_2997: acompr deflate(6) of 128kB chunks took 38262 us (3 MB/s), compress ratio: 3.09 [ 366.102746] lustre_kcompr_2997: adecompr deflate(6) took 1794 us (22 MB/s) [ 366.118584] lustre_kcompr_2997: test_acomp_compress_decompress(deflate,6) ret 0 [ 366.979297] lustre_kcompr_2997: compr deflate(9) in 64kB chunks took 844901 us (4 MB/s), compress ratio: 3.51 [ 367.819249] lustre_kcompr_2997: compr deflate(9) in 128kB chunks took 834032 us (4 MB/s), compress ratio: 3.53 [ 368.494858] lustre_kcompr_2997: compr deflate(9) in 256kB chunks took 669689 us (5 MB/s), compress ratio: 3.53 [ 369.190841] lustre_kcompr_2997: compr deflate(9) in 512kB chunks took 690085 us (5 MB/s), compress ratio: 3.54 [ 369.949204] lustre_kcompr_2997: compr deflate(9) in 1024kB chunks took 751468 us (5 MB/s), compress ratio: 3.54 [ 370.461391] lustre_kcompr_2997: compr deflate(9) in 2048kB chunks took 506994 us (7 MB/s), compress ratio: 3.54 [ 370.997036] lustre_kcompr_2997: compr deflate(9) in 4096kB chunks took 524459 us (7 MB/s), compress ratio: 3.54 [ 371.038580] lustre_kcompr_2997: decompr deflate(9) took 31858 us (35 MB/s) [ 371.043729] lustre_kcompr_2997: test_comp_compress_decompress(deflate,9) ret 0 [ 371.062884] lustre_kcompr_2997: acompr deflate(9) of 128kB chunks took 14333 us (8 MB/s), compress ratio: 3.09 [ 371.068663] lustre_kcompr_2997: adecompr deflate(9) took 1205 us (33 MB/s) [ 371.073891] lustre_kcompr_2997: test_acomp_compress_decompress(deflate,9) ret 0 [ 371.178341] lustre_kcompr_2997: compr zstd(0) in 64kB chunks took 83163 us (48 MB/s), compress ratio: 4.28 [ 371.249503] lustre_kcompr_2997: compr zstd(0) in 128kB chunks took 61567 us (64 MB/s), compress ratio: 4.46 [ 371.309332] lustre_kcompr_2997: compr zstd(0) in 256kB chunks took 56319 us (71 MB/s), compress ratio: 4.61 [ 371.485401] lustre_kcompr_2997: compr zstd(0) in 512kB chunks took 169301 us (23 MB/s), compress ratio: 4.72 [ 371.685224] lustre_kcompr_2997: compr zstd(0) in 1024kB chunks took 192172 us (20 MB/s), compress ratio: 4.80 [ 371.759831] lustre_kcompr_2997: compr zstd(0) in 2048kB chunks took 71138 us (56 MB/s), compress ratio: 4.85 [ 371.921908] lustre_kcompr_2997: compr zstd(0) in 4096kB chunks took 159316 us (25 MB/s), compress ratio: 4.88 [ 371.968923] lustre_kcompr_2997: decompr zstd(0) took 34979 us (23 MB/s) [ 371.973918] lustre_kcompr_2997: test_comp_compress_decompress(zstd,0) ret 0 [ 371.980597] lustre_kcompr_2997: acompr zstd(0) of 128kB chunks took 2191 us (57 MB/s), compress ratio: 3.98 [ 371.987463] lustre_kcompr_2997: adecompr zstd(0) took 505 us (62 MB/s) [ 371.993517] lustre_kcompr_2997: test_acomp_compress_decompress(zstd,0) ret 0 [ 372.062552] lustre_kcompr_2997: compr zstd(1) in 64kB chunks took 48304 us (82 MB/s), compress ratio: 4.06 [ 372.134842] lustre_kcompr_2997: compr zstd(1) in 128kB chunks took 67989 us (58 MB/s), compress ratio: 4.20 [ 372.203282] lustre_kcompr_2997: compr zstd(1) in 256kB chunks took 63301 us (63 MB/s), compress ratio: 4.34 [ 372.266758] lustre_kcompr_2997: compr zstd(1) in 512kB chunks took 54205 us (73 MB/s), compress ratio: 4.34 [ 372.352645] lustre_kcompr_2997: compr zstd(1) in 1024kB chunks took 80705 us (49 MB/s), compress ratio: 4.37 [ 372.453694] lustre_kcompr_2997: compr zstd(1) in 2048kB chunks took 93310 us (42 MB/s), compress ratio: 4.39 [ 372.601646] lustre_kcompr_2997: compr zstd(1) in 4096kB chunks took 130813 us (30 MB/s), compress ratio: 4.40 [ 372.645867] lustre_kcompr_2997: decompr zstd(1) took 25684 us (35 MB/s) [ 372.657682] lustre_kcompr_2997: test_comp_compress_decompress(zstd,1) ret 0 [ 372.672443] lustre_kcompr_2997: acompr zstd(1) of 128kB chunks took 3621 us (34 MB/s), compress ratio: 3.73 [ 372.682579] lustre_kcompr_2997: adecompr zstd(1) took 436 us (76 MB/s) [ 372.693889] lustre_kcompr_2997: test_acomp_compress_decompress(zstd,1) ret 0 [ 373.769943] lustre_kcompr_2997: compr zstd(10) in 64kB chunks took 1068133 us (3 MB/s), compress ratio: 4.80 [ 375.352728] lustre_kcompr_2997: compr zstd(10) in 128kB chunks took 1573445 us (2 MB/s), compress ratio: 5.09 [ 376.887055] lustre_kcompr_2997: compr zstd(10) in 256kB chunks took 1524117 us (2 MB/s), compress ratio: 5.34 [ 378.079744] lustre_kcompr_2997: compr zstd(10) in 512kB chunks took 1187942 us (3 MB/s), compress ratio: 5.45 [ 379.530572] lustre_kcompr_2997: compr zstd(10) in 1024kB chunks took 1438854 us (2 MB/s), compress ratio: 5.62 [ 380.842603] lustre_kcompr_2997: compr zstd(10) in 2048kB chunks took 1306211 us (3 MB/s), compress ratio: 5.76 [ 382.499825] lustre_kcompr_2997: compr zstd(10) in 4096kB chunks took 1651075 us (2 MB/s), compress ratio: 5.89 [ 382.542320] lustre_kcompr_2997: decompr zstd(10) took 24619 us (27 MB/s) [ 382.547167] lustre_kcompr_2997: test_comp_compress_decompress(zstd,10) ret 0 [ 382.619511] lustre_kcompr_2997: acompr zstd(10) of 128kB chunks took 54668 us (2 MB/s), compress ratio: 4.46 [ 382.625197] lustre_kcompr_2997: adecompr zstd(10) took 974 us (28 MB/s) [ 382.630263] lustre_kcompr_2997: test_acomp_compress_decompress(zstd,10) ret 0 [ 397.395853] lustre_kcompr_2997: compr zstd(15) in 64kB chunks took 14756222 us (0 MB/s), compress ratio: 4.96 [ 410.130918] lustre_kcompr_2997: compr zstd(15) in 128kB chunks took 12725914 us (0 MB/s), compress ratio: 5.28 [ 418.604482] lustre_kcompr_2997: compr zstd(15) in 256kB chunks took 8470392 us (0 MB/s), compress ratio: 5.57 [ 428.242594] lustre_kcompr_2997: compr zstd(15) in 512kB chunks took 9617794 us (0 MB/s), compress ratio: 5.83 [ 439.346102] lustre_kcompr_2997: compr zstd(15) in 1024kB chunks took 11100715 us (0 MB/s), compress ratio: 6.06 [ 448.541620] lustre_kcompr_2997: compr zstd(15) in 2048kB chunks took 9192141 us (0 MB/s), compress ratio: 6.26 [ 461.341982] lustre_kcompr_2997: compr zstd(15) in 4096kB chunks took 12775819 us (0 MB/s), compress ratio: 6.46 [ 461.410748] lustre_kcompr_2997: decompr zstd(15) took 39629 us (15 MB/s) [ 461.417979] lustre_kcompr_2997: test_comp_compress_decompress(zstd,15) ret 0 [ 461.852702] lustre_kcompr_2997: acompr zstd(15) of 128kB chunks took 423587 us (0 MB/s), compress ratio: 4.64 [ 461.874440] lustre_kcompr_2997: adecompr zstd(15) took 10545 us (2 MB/s) [ 461.890966] lustre_kcompr_2997: test_acomp_compress_decompress(zstd,15) ret 0 [ 462.031438] lustre_kcompr_2997: compr zstdfast(1) in 64kB chunks took 120433 us (33 MB/s), compress ratio: 3.49 [ 462.134426] lustre_kcompr_2997: compr zstdfast(1) in 128kB chunks took 82708 us (48 MB/s), compress ratio: 3.62 [ 462.225443] lustre_kcompr_2997: compr zstdfast(1) in 256kB chunks took 78679 us (50 MB/s), compress ratio: 3.84 [ 462.288664] lustre_kcompr_2997: compr zstdfast(1) in 512kB chunks took 53926 us (74 MB/s), compress ratio: 3.73 [ 462.360785] lustre_kcompr_2997: compr zstdfast(1) in 1024kB chunks took 62381 us (64 MB/s), compress ratio: 3.76 [ 462.434318] lustre_kcompr_2997: compr zstdfast(1) in 2048kB chunks took 63175 us (63 MB/s), compress ratio: 3.77 [ 462.532194] lustre_kcompr_2997: compr zstdfast(1) in 4096kB chunks took 91985 us (43 MB/s), compress ratio: 3.78 [ 462.594564] lustre_kcompr_2997: decompr zstdfast(1) took 31755 us (33 MB/s) [ 462.602274] lustre_kcompr_2997: test_comp_compress_decompress(zstdfast,1) ret 0 [ 462.627683] lustre_kcompr_2997: acompr zstdfast(1) of 128kB chunks took 3803 us (32 MB/s), compress ratio: 3.19 [ 462.636783] lustre_kcompr_2997: adecompr zstdfast(1) took 432 us (90 MB/s) [ 462.662814] lustre_kcompr_2997: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 462.758683] lustre_kcompr_2997: compr zstdfast(5) in 64kB chunks took 70268 us (56 MB/s), compress ratio: 2.81 [ 462.851194] lustre_kcompr_2997: compr zstdfast(5) in 128kB chunks took 80438 us (49 MB/s), compress ratio: 2.93 [ 462.930751] lustre_kcompr_2997: compr zstdfast(5) in 256kB chunks took 65844 us (60 MB/s), compress ratio: 3.16 [ 463.047452] lustre_kcompr_2997: compr zstdfast(5) in 512kB chunks took 92623 us (43 MB/s), compress ratio: 3.04 [ 463.134175] lustre_kcompr_2997: compr zstdfast(5) in 1024kB chunks took 78438 us (50 MB/s), compress ratio: 3.07 [ 463.202787] lustre_kcompr_2997: compr zstdfast(5) in 2048kB chunks took 60959 us (65 MB/s), compress ratio: 3.08 [ 463.284979] lustre_kcompr_2997: compr zstdfast(5) in 4096kB chunks took 72504 us (55 MB/s), compress ratio: 3.09 [ 463.335606] lustre_kcompr_2997: decompr zstdfast(5) took 31179 us (41 MB/s) [ 463.347503] lustre_kcompr_2997: test_comp_compress_decompress(zstdfast,5) ret 0 [ 463.354306] lustre_kcompr_2997: acompr zstdfast(5) of 128kB chunks took 1821 us (68 MB/s), compress ratio: 2.56 [ 463.365067] lustre_kcompr_2997: adecompr zstdfast(5) took 697 us (69 MB/s) [ 463.392114] lustre_kcompr_2997: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 463.437445] lustre_kcompr_2997: compr zstdfast(12) in 64kB chunks took 23592 us (169 MB/s), compress ratio: 1.43 [ 463.481492] lustre_kcompr_2997: compr zstdfast(12) in 128kB chunks took 33018 us (121 MB/s), compress ratio: 1.50 [ 463.523455] lustre_kcompr_2997: compr zstdfast(12) in 256kB chunks took 36157 us (110 MB/s), compress ratio: 1.62 [ 463.566602] lustre_kcompr_2997: compr zstdfast(12) in 512kB chunks took 33955 us (117 MB/s), compress ratio: 1.55 [ 463.644195] lustre_kcompr_2997: compr zstdfast(12) in 1024kB chunks took 66332 us (60 MB/s), compress ratio: 1.58 [ 463.694683] lustre_kcompr_2997: compr zstdfast(12) in 2048kB chunks took 33147 us (120 MB/s), compress ratio: 1.60 [ 463.762119] lustre_kcompr_2997: compr zstdfast(12) in 4096kB chunks took 61297 us (65 MB/s), compress ratio: 1.60 [ 463.793300] lustre_kcompr_2997: decompr zstdfast(12) took 11525 us (216 MB/s) [ 463.800199] lustre_kcompr_2997: test_comp_compress_decompress(zstdfast,12) ret 0 [ 463.808530] lustre_kcompr_2997: acompr zstdfast(12) of 128kB chunks took 646 us (193 MB/s), compress ratio: 1.37 [ 463.812907] lustre_kcompr_2997: adecompr zstdfast(12) took 347 us (262 MB/s) [ 463.818988] lustre_kcompr_2997: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 463.840205] lustre_kcompr_2997: compr zstdfast(15) in 64kB chunks took 11435 us (349 MB/s), compress ratio: 1.12 [ 463.858433] lustre_kcompr_2997: compr zstdfast(15) in 128kB chunks took 12248 us (326 MB/s), compress ratio: 1.16 [ 463.883133] lustre_kcompr_2997: compr zstdfast(15) in 256kB chunks took 14906 us (268 MB/s), compress ratio: 1.22 [ 463.903358] lustre_kcompr_2997: compr zstdfast(15) in 512kB chunks took 14021 us (285 MB/s), compress ratio: 1.20 [ 463.925132] lustre_kcompr_2997: compr zstdfast(15) in 1024kB chunks took 15679 us (255 MB/s), compress ratio: 1.22 [ 463.948700] lustre_kcompr_2997: compr zstdfast(15) in 2048kB chunks took 18447 us (216 MB/s), compress ratio: 1.23 [ 463.992572] lustre_kcompr_2997: compr zstdfast(15) in 4096kB chunks took 30389 us (131 MB/s), compress ratio: 1.23 [ 464.015901] lustre_kcompr_2997: decompr zstdfast(15) took 7628 us (424 MB/s) [ 464.022178] lustre_kcompr_2997: test_comp_compress_decompress(zstdfast,15) ret 0 [ 464.029343] lustre_kcompr_2997: acompr zstdfast(15) of 128kB chunks took 455 us (274 MB/s), compress ratio: 1.08 [ 464.035737] lustre_kcompr_2997: adecompr zstdfast(15) took 171 us (675 MB/s) [ 464.042320] lustre_kcompr_2997: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 464.046450] lustre_kcompr_2997: SUCCESS [ 467.496537] lustre_kcompr_15248: ***** [ 467.499460] lustre_kcompr_15248: (de)compression test on provided file /tmp/f84.sanity [ 467.505721] lustre_kcompr_15248: ***** [ 467.537846] lustre_kcompr_15248: compr lz4(1) in 64kB chunks took 21406 us (186 MB/s), compress ratio: 2.45 [ 467.566665] lustre_kcompr_15248: compr lz4(1) in 128kB chunks took 23165 us (172 MB/s), compress ratio: 2.39 [ 467.595864] lustre_kcompr_15248: compr lz4(1) in 256kB chunks took 24862 us (160 MB/s), compress ratio: 2.39 [ 467.624561] lustre_kcompr_15248: compr lz4(1) in 512kB chunks took 22729 us (175 MB/s), compress ratio: 2.39 [ 467.676351] lustre_kcompr_15248: compr lz4(1) in 1024kB chunks took 38423 us (104 MB/s), compress ratio: 2.39 [ 467.716144] lustre_kcompr_15248: compr lz4(1) in 2048kB chunks took 25043 us (159 MB/s), compress ratio: 2.39 [ 467.771454] lustre_kcompr_15248: compr lz4(1) in 4096kB chunks took 39727 us (100 MB/s), compress ratio: 2.39 [ 467.804991] lustre_kcompr_15248: decompr lz4(1) took 6810 us (245 MB/s) [ 467.815361] lustre_kcompr_15248: test_comp_compress_decompress(lz4,1) ret 0 [ 467.829313] lustre_kcompr_15248: acompr lz4(1) of 128kB chunks took 139 us (899 MB/s), compress ratio: 15.67 [ 467.838286] lustre_kcompr_15248: adecompr lz4(1) took 91 us (87 MB/s) [ 467.866280] lustre_kcompr_15248: test_acomp_compress_decompress(lz4,1) ret 0 [ 467.922907] lustre_kcompr_15248: compr lz4(4) in 64kB chunks took 18733 us (213 MB/s), compress ratio: 2.36 [ 467.949979] lustre_kcompr_15248: compr lz4(4) in 128kB chunks took 15554 us (257 MB/s), compress ratio: 2.35 [ 467.967840] lustre_kcompr_15248: compr lz4(4) in 256kB chunks took 12380 us (323 MB/s), compress ratio: 2.35 [ 467.993935] lustre_kcompr_15248: compr lz4(4) in 512kB chunks took 20655 us (193 MB/s), compress ratio: 2.35 [ 468.008284] lustre_kcompr_15248: compr lz4(4) in 1024kB chunks took 8160 us (490 MB/s), compress ratio: 2.35 [ 468.024475] lustre_kcompr_15248: compr lz4(4) in 2048kB chunks took 12973 us (308 MB/s), compress ratio: 2.35 [ 468.048978] lustre_kcompr_15248: compr lz4(4) in 4096kB chunks took 18397 us (217 MB/s), compress ratio: 2.35 [ 468.068454] lustre_kcompr_15248: decompr lz4(4) took 6947 us (244 MB/s) [ 468.073398] lustre_kcompr_15248: test_comp_compress_decompress(lz4,4) ret 0 [ 468.080354] lustre_kcompr_15248: acompr lz4(4) of 128kB chunks took 142 us (880 MB/s), compress ratio: 15.30 [ 468.087360] lustre_kcompr_15248: adecompr lz4(4) took 92 us (88 MB/s) [ 468.095634] lustre_kcompr_15248: test_acomp_compress_decompress(lz4,4) ret 0 [ 468.119694] lustre_kcompr_15248: compr lz4(9) in 64kB chunks took 12400 us (322 MB/s), compress ratio: 2.32 [ 468.135633] lustre_kcompr_15248: compr lz4(9) in 128kB chunks took 9763 us (409 MB/s), compress ratio: 2.31 [ 468.152930] lustre_kcompr_15248: compr lz4(9) in 256kB chunks took 11976 us (334 MB/s), compress ratio: 2.31 [ 468.190990] lustre_kcompr_15248: compr lz4(9) in 512kB chunks took 30532 us (131 MB/s), compress ratio: 2.31 [ 468.228685] lustre_kcompr_15248: compr lz4(9) in 1024kB chunks took 27605 us (144 MB/s), compress ratio: 2.31 [ 468.258903] lustre_kcompr_15248: compr lz4(9) in 2048kB chunks took 18946 us (211 MB/s), compress ratio: 2.32 [ 468.289831] lustre_kcompr_15248: compr lz4(9) in 4096kB chunks took 22481 us (177 MB/s), compress ratio: 2.32 [ 468.318812] lustre_kcompr_15248: decompr lz4(9) took 3968 us (434 MB/s) [ 468.332395] lustre_kcompr_15248: test_comp_compress_decompress(lz4,9) ret 0 [ 468.341755] lustre_kcompr_15248: acompr lz4(9) of 128kB chunks took 378 us (330 MB/s), compress ratio: 14.81 [ 468.357949] lustre_kcompr_15248: adecompr lz4(9) took 132 us (63 MB/s) [ 468.386440] lustre_kcompr_15248: test_acomp_compress_decompress(lz4,9) ret 0 [ 468.422941] lustre_kcompr_15248: compr lz4(15) in 64kB chunks took 7302 us (547 MB/s), compress ratio: 2.23 [ 468.438254] lustre_kcompr_15248: compr lz4(15) in 128kB chunks took 6857 us (583 MB/s), compress ratio: 2.23 [ 468.453225] lustre_kcompr_15248: compr lz4(15) in 256kB chunks took 8195 us (488 MB/s), compress ratio: 2.23 [ 468.472226] lustre_kcompr_15248: compr lz4(15) in 512kB chunks took 13304 us (300 MB/s), compress ratio: 2.23 [ 468.496110] lustre_kcompr_15248: compr lz4(15) in 1024kB chunks took 13407 us (298 MB/s), compress ratio: 2.23 [ 468.508349] lustre_kcompr_15248: compr lz4(15) in 2048kB chunks took 5743 us (696 MB/s), compress ratio: 2.23 [ 468.519142] lustre_kcompr_15248: compr lz4(15) in 4096kB chunks took 6279 us (637 MB/s), compress ratio: 2.23 [ 468.532185] lustre_kcompr_15248: decompr lz4(15) took 2806 us (637 MB/s) [ 468.537233] lustre_kcompr_15248: test_comp_compress_decompress(lz4,15) ret 0 [ 468.542861] lustre_kcompr_15248: acompr lz4(15) of 128kB chunks took 134 us (932 MB/s), compress ratio: 14.18 [ 468.547534] lustre_kcompr_15248: adecompr lz4(15) took 92 us (95 MB/s) [ 468.558196] lustre_kcompr_15248: test_acomp_compress_decompress(lz4,15) ret 0 [ 468.747823] lustre_kcompr_15248: compr lz4hc(1) in 64kB chunks took 173604 us (23 MB/s), compress ratio: 2.54 [ 469.004706] lustre_kcompr_15248: compr lz4hc(1) in 128kB chunks took 240530 us (16 MB/s), compress ratio: 2.61 [ 469.312235] lustre_kcompr_15248: compr lz4hc(1) in 256kB chunks took 291245 us (13 MB/s), compress ratio: 2.64 [ 469.555263] lustre_kcompr_15248: compr lz4hc(1) in 512kB chunks took 232093 us (17 MB/s), compress ratio: 2.66 [ 469.854072] lustre_kcompr_15248: compr lz4hc(1) in 1024kB chunks took 287988 us (13 MB/s), compress ratio: 2.67 [ 470.131481] lustre_kcompr_15248: compr lz4hc(1) in 2048kB chunks took 265709 us (15 MB/s), compress ratio: 2.67 [ 470.365852] lustre_kcompr_15248: compr lz4hc(1) in 4096kB chunks took 225353 us (17 MB/s), compress ratio: 2.67 [ 470.384056] lustre_kcompr_15248: decompr lz4hc(1) took 6525 us (228 MB/s) [ 470.391907] lustre_kcompr_15248: test_comp_compress_decompress(lz4hc,1) ret 0 [ 470.401147] lustre_kcompr_15248: acompr lz4hc(1) of 128kB chunks took 1479 us (84 MB/s), compress ratio: 15.97 [ 470.409316] lustre_kcompr_15248: adecompr lz4hc(1) took 97 us (80 MB/s) [ 470.421593] lustre_kcompr_15248: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 470.658933] lustre_kcompr_15248: compr lz4hc(3) in 64kB chunks took 219061 us (18 MB/s), compress ratio: 2.57 [ 470.861644] lustre_kcompr_15248: compr lz4hc(3) in 128kB chunks took 196942 us (20 MB/s), compress ratio: 2.64 [ 471.019880] lustre_kcompr_15248: compr lz4hc(3) in 256kB chunks took 147027 us (27 MB/s), compress ratio: 2.68 [ 471.235474] lustre_kcompr_15248: compr lz4hc(3) in 512kB chunks took 207300 us (19 MB/s), compress ratio: 2.69 [ 471.469908] lustre_kcompr_15248: compr lz4hc(3) in 1024kB chunks took 228612 us (17 MB/s), compress ratio: 2.70 [ 471.730217] lustre_kcompr_15248: compr lz4hc(3) in 2048kB chunks took 250961 us (15 MB/s), compress ratio: 2.71 [ 472.087313] lustre_kcompr_15248: compr lz4hc(3) in 4096kB chunks took 347107 us (11 MB/s), compress ratio: 2.71 [ 472.122236] lustre_kcompr_15248: decompr lz4hc(3) took 12775 us (115 MB/s) [ 472.129508] lustre_kcompr_15248: test_comp_compress_decompress(lz4hc,3) ret 0 [ 472.136676] lustre_kcompr_15248: acompr lz4hc(3) of 128kB chunks took 3287 us (38 MB/s), compress ratio: 16.00 [ 472.147318] lustre_kcompr_15248: adecompr lz4hc(3) took 221 us (35 MB/s) [ 472.160956] lustre_kcompr_15248: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 472.793515] lustre_kcompr_15248: compr lz4hc(8) in 64kB chunks took 601783 us (6 MB/s), compress ratio: 2.60 [ 473.262380] lustre_kcompr_15248: compr lz4hc(8) in 128kB chunks took 463790 us (8 MB/s), compress ratio: 2.66 [ 473.640437] lustre_kcompr_15248: compr lz4hc(8) in 256kB chunks took 373560 us (10 MB/s), compress ratio: 2.70 [ 474.418121] lustre_kcompr_15248: compr lz4hc(8) in 512kB chunks took 768608 us (5 MB/s), compress ratio: 2.71 [ 475.201676] lustre_kcompr_15248: compr lz4hc(8) in 1024kB chunks took 776604 us (5 MB/s), compress ratio: 2.72 [ 476.006958] lustre_kcompr_15248: compr lz4hc(8) in 2048kB chunks took 798158 us (5 MB/s), compress ratio: 2.73 [ 476.723327] lustre_kcompr_15248: compr lz4hc(8) in 4096kB chunks took 707259 us (5 MB/s), compress ratio: 2.73 [ 476.746665] lustre_kcompr_15248: decompr lz4hc(8) took 8088 us (180 MB/s) [ 476.753132] lustre_kcompr_15248: test_comp_compress_decompress(lz4hc,8) ret 0 [ 476.772146] lustre_kcompr_15248: acompr lz4hc(8) of 128kB chunks took 10334 us (12 MB/s), compress ratio: 16.17 [ 476.777663] lustre_kcompr_15248: adecompr lz4hc(8) took 119 us (64 MB/s) [ 476.783647] lustre_kcompr_15248: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 484.229943] lustre_kcompr_15248: compr lz4hc(15) in 64kB chunks took 7432633 us (0 MB/s), compress ratio: 2.61 [ 493.409749] lustre_kcompr_15248: compr lz4hc(15) in 128kB chunks took 9167483 us (0 MB/s), compress ratio: 2.67 [ 504.310971] lustre_kcompr_15248: compr lz4hc(15) in 256kB chunks took 10893135 us (0 MB/s), compress ratio: 2.71 [ 516.765934] lustre_kcompr_15248: compr lz4hc(15) in 512kB chunks took 12449712 us (0 MB/s), compress ratio: 2.72 [ 527.135440] lustre_kcompr_15248: compr lz4hc(15) in 1024kB chunks took 10360541 us (0 MB/s), compress ratio: 2.73 [ 542.485567] lustre_kcompr_15248: compr lz4hc(15) in 2048kB chunks took 15345116 us (0 MB/s), compress ratio: 2.74 [ 557.073229] lustre_kcompr_15248: compr lz4hc(15) in 4096kB chunks took 14570152 us (0 MB/s), compress ratio: 2.74 [ 557.085428] lustre_kcompr_15248: decompr lz4hc(15) took 3679 us (395 MB/s) [ 557.088726] lustre_kcompr_15248: test_comp_compress_decompress(lz4hc,15) ret 0 [ 557.107397] lustre_kcompr_15248: acompr lz4hc(15) of 128kB chunks took 14925 us (8 MB/s), compress ratio: 16.30 [ 557.110602] lustre_kcompr_15248: adecompr lz4hc(15) took 162 us (47 MB/s) [ 557.118670] lustre_kcompr_15248: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 557.132876] lustre_kcompr_15248: compr lzo(-1) in 64kB chunks took 11270 us (354 MB/s), compress ratio: 2.35 [ 557.148045] lustre_kcompr_15248: compr lzo(-1) in 128kB chunks took 11319 us (353 MB/s), compress ratio: 2.35 [ 557.171811] lustre_kcompr_15248: compr lzo(-1) in 256kB chunks took 20086 us (199 MB/s), compress ratio: 2.35 [ 557.199563] lustre_kcompr_15248: compr lzo(-1) in 512kB chunks took 16857 us (237 MB/s), compress ratio: 2.36 [ 557.222503] lustre_kcompr_15248: compr lzo(-1) in 1024kB chunks took 18076 us (221 MB/s), compress ratio: 2.36 [ 557.244199] lustre_kcompr_15248: compr lzo(-1) in 2048kB chunks took 16701 us (239 MB/s), compress ratio: 2.36 [ 557.266857] lustre_kcompr_15248: compr lzo(-1) in 4096kB chunks took 16157 us (247 MB/s), compress ratio: 2.36 [ 557.289800] lustre_kcompr_15248: decompr lzo(-1) took 7302 us (231 MB/s) [ 557.293504] lustre_kcompr_15248: test_comp_compress_decompress(lzo,-1) ret 0 [ 557.296467] lustre_kcompr_15248: acompr lzo(-1) of 128kB chunks took 221 us (565 MB/s), compress ratio: 15.45 [ 557.299681] lustre_kcompr_15248: adecompr lzo(-1) took 256 us (31 MB/s) [ 557.305159] lustre_kcompr_15248: test_acomp_compress_decompress(lzo,-1) ret 0 [ 557.686173] lustre_kcompr_15248: compr deflate(1) in 64kB chunks took 369373 us (10 MB/s), compress ratio: 3.27 [ 558.310089] lustre_kcompr_15248: compr deflate(1) in 128kB chunks took 610395 us (6 MB/s), compress ratio: 3.28 [ 558.833436] lustre_kcompr_15248: compr deflate(1) in 256kB chunks took 515466 us (7 MB/s), compress ratio: 3.28 [ 559.259801] lustre_kcompr_15248: compr deflate(1) in 512kB chunks took 422737 us (9 MB/s), compress ratio: 3.28 [ 559.850207] lustre_kcompr_15248: compr deflate(1) in 1024kB chunks took 582032 us (6 MB/s), compress ratio: 3.28 [ 560.272721] lustre_kcompr_15248: compr deflate(1) in 2048kB chunks took 418930 us (9 MB/s), compress ratio: 3.28 [ 560.779515] lustre_kcompr_15248: compr deflate(1) in 4096kB chunks took 498406 us (8 MB/s), compress ratio: 3.28 [ 560.811727] lustre_kcompr_15248: decompr deflate(1) took 24544 us (49 MB/s) [ 560.815635] lustre_kcompr_15248: test_comp_compress_decompress(deflate,1) ret 0 [ 560.827555] lustre_kcompr_15248: acompr deflate(1) of 128kB chunks took 8771 us (14 MB/s), compress ratio: 21.43 [ 560.830731] lustre_kcompr_15248: adecompr deflate(1) took 276 us (21 MB/s) [ 560.837325] lustre_kcompr_15248: test_acomp_compress_decompress(deflate,1) ret 0 [ 561.229432] lustre_kcompr_15248: compr deflate(6) in 64kB chunks took 381941 us (10 MB/s), compress ratio: 3.27 [ 561.641733] lustre_kcompr_15248: compr deflate(6) in 128kB chunks took 408411 us (9 MB/s), compress ratio: 3.28 [ 562.211989] lustre_kcompr_15248: compr deflate(6) in 256kB chunks took 562673 us (7 MB/s), compress ratio: 3.28 [ 562.777680] lustre_kcompr_15248: compr deflate(6) in 512kB chunks took 540011 us (7 MB/s), compress ratio: 3.28 [ 563.251372] lustre_kcompr_15248: compr deflate(6) in 1024kB chunks took 468217 us (8 MB/s), compress ratio: 3.28 [ 563.742433] lustre_kcompr_15248: compr deflate(6) in 2048kB chunks took 482570 us (8 MB/s), compress ratio: 3.28 [ 564.095145] lustre_kcompr_15248: compr deflate(6) in 4096kB chunks took 348553 us (11 MB/s), compress ratio: 3.28 [ 564.124588] lustre_kcompr_15248: decompr deflate(6) took 21500 us (56 MB/s) [ 564.135922] lustre_kcompr_15248: test_comp_compress_decompress(deflate,6) ret 0 [ 564.194926] lustre_kcompr_15248: acompr deflate(6) of 128kB chunks took 30597 us (4 MB/s), compress ratio: 21.43 [ 564.206285] lustre_kcompr_15248: adecompr deflate(6) took 350 us (16 MB/s) [ 564.223966] lustre_kcompr_15248: test_acomp_compress_decompress(deflate,6) ret 0 [ 564.730536] lustre_kcompr_15248: compr deflate(9) in 64kB chunks took 485767 us (8 MB/s), compress ratio: 3.27 [ 565.284852] lustre_kcompr_15248: compr deflate(9) in 128kB chunks took 549109 us (7 MB/s), compress ratio: 3.28 [ 565.820656] lustre_kcompr_15248: compr deflate(9) in 256kB chunks took 531301 us (7 MB/s), compress ratio: 3.28 [ 566.345301] lustre_kcompr_15248: compr deflate(9) in 512kB chunks took 520842 us (7 MB/s), compress ratio: 3.28 [ 567.008982] lustre_kcompr_15248: compr deflate(9) in 1024kB chunks took 650393 us (6 MB/s), compress ratio: 3.28 [ 567.487674] lustre_kcompr_15248: compr deflate(9) in 2048kB chunks took 462688 us (8 MB/s), compress ratio: 3.28 [ 567.941804] lustre_kcompr_15248: compr deflate(9) in 4096kB chunks took 450470 us (8 MB/s), compress ratio: 3.28 [ 567.978919] lustre_kcompr_15248: decompr deflate(9) took 28468 us (42 MB/s) [ 567.986185] lustre_kcompr_15248: test_comp_compress_decompress(deflate,9) ret 0 [ 568.007694] lustre_kcompr_15248: acompr deflate(9) of 128kB chunks took 13344 us (9 MB/s), compress ratio: 21.43 [ 568.016702] lustre_kcompr_15248: adecompr deflate(9) took 1860 us (3 MB/s) [ 568.034101] lustre_kcompr_15248: test_acomp_compress_decompress(deflate,9) ret 0 [ 568.186192] lustre_kcompr_15248: compr zstd(0) in 64kB chunks took 106883 us (37 MB/s), compress ratio: 3.28 [ 568.248406] lustre_kcompr_15248: compr zstd(0) in 128kB chunks took 58470 us (68 MB/s), compress ratio: 3.26 [ 568.360316] lustre_kcompr_15248: compr zstd(0) in 256kB chunks took 107500 us (37 MB/s), compress ratio: 3.31 [ 568.538522] lustre_kcompr_15248: compr zstd(0) in 512kB chunks took 172194 us (23 MB/s), compress ratio: 3.32 [ 568.689683] lustre_kcompr_15248: compr zstd(0) in 1024kB chunks took 146833 us (27 MB/s), compress ratio: 3.32 [ 568.926477] lustre_kcompr_15248: compr zstd(0) in 2048kB chunks took 228477 us (17 MB/s), compress ratio: 3.33 [ 569.111466] lustre_kcompr_15248: compr zstd(0) in 4096kB chunks took 177147 us (22 MB/s), compress ratio: 3.33 [ 569.143462] lustre_kcompr_15248: decompr zstd(0) took 20259 us (59 MB/s) [ 569.154771] lustre_kcompr_15248: test_comp_compress_decompress(zstd,0) ret 0 [ 569.161770] lustre_kcompr_15248: acompr zstd(0) of 128kB chunks took 415 us (301 MB/s), compress ratio: 22.64 [ 569.166964] lustre_kcompr_15248: adecompr zstd(0) took 163 us (33 MB/s) [ 569.173368] lustre_kcompr_15248: test_acomp_compress_decompress(zstd,0) ret 0 [ 569.231372] lustre_kcompr_15248: compr zstd(1) in 64kB chunks took 47484 us (84 MB/s), compress ratio: 3.22 [ 569.289839] lustre_kcompr_15248: compr zstd(1) in 128kB chunks took 52516 us (76 MB/s), compress ratio: 3.18 [ 569.354438] lustre_kcompr_15248: compr zstd(1) in 256kB chunks took 58609 us (68 MB/s), compress ratio: 3.19 [ 569.415892] lustre_kcompr_15248: compr zstd(1) in 512kB chunks took 55552 us (72 MB/s), compress ratio: 3.19 [ 569.477217] lustre_kcompr_15248: compr zstd(1) in 1024kB chunks took 51971 us (76 MB/s), compress ratio: 3.19 [ 569.539554] lustre_kcompr_15248: compr zstd(1) in 2048kB chunks took 55257 us (72 MB/s), compress ratio: 3.19 [ 569.601962] lustre_kcompr_15248: compr zstd(1) in 4096kB chunks took 55157 us (72 MB/s), compress ratio: 3.19 [ 569.645228] lustre_kcompr_15248: decompr zstd(1) took 25145 us (49 MB/s) [ 569.650921] lustre_kcompr_15248: test_comp_compress_decompress(zstd,1) ret 0 [ 569.666925] lustre_kcompr_15248: acompr zstd(1) of 128kB chunks took 280 us (446 MB/s), compress ratio: 22.79 [ 569.675737] lustre_kcompr_15248: adecompr zstd(1) took 2670 us (2 MB/s) [ 569.700295] lustre_kcompr_15248: test_acomp_compress_decompress(zstd,1) ret 0 [ 570.556798] lustre_kcompr_15248: compr zstd(10) in 64kB chunks took 820888 us (4 MB/s), compress ratio: 3.33 [ 571.307586] lustre_kcompr_15248: compr zstd(10) in 128kB chunks took 738207 us (5 MB/s), compress ratio: 3.33 [ 572.158406] lustre_kcompr_15248: compr zstd(10) in 256kB chunks took 845105 us (4 MB/s), compress ratio: 3.37 [ 572.929249] lustre_kcompr_15248: compr zstd(10) in 512kB chunks took 765542 us (5 MB/s), compress ratio: 3.40 [ 573.977098] lustre_kcompr_15248: compr zstd(10) in 1024kB chunks took 1040236 us (3 MB/s), compress ratio: 3.42 [ 574.755580] lustre_kcompr_15248: compr zstd(10) in 2048kB chunks took 769971 us (5 MB/s), compress ratio: 3.46 [ 576.255199] lustre_kcompr_15248: compr zstd(10) in 4096kB chunks took 1496287 us (2 MB/s), compress ratio: 3.50 [ 576.325339] lustre_kcompr_15248: decompr zstd(10) took 48277 us (23 MB/s) [ 576.334589] lustre_kcompr_15248: test_comp_compress_decompress(zstd,10) ret 0 [ 576.347515] lustre_kcompr_15248: acompr zstd(10) of 128kB chunks took 7791 us (16 MB/s), compress ratio: 22.78 [ 576.353688] lustre_kcompr_15248: adecompr zstd(10) took 149 us (36 MB/s) [ 576.373316] lustre_kcompr_15248: test_acomp_compress_decompress(zstd,10) ret 0 [ 585.188602] lustre_kcompr_15248: compr zstd(15) in 64kB chunks took 8800939 us (0 MB/s), compress ratio: 3.36 [ 592.264116] lustre_kcompr_15248: compr zstd(15) in 128kB chunks took 7070420 us (0 MB/s), compress ratio: 3.39 [ 597.110596] lustre_kcompr_15248: compr zstd(15) in 256kB chunks took 4842122 us (0 MB/s), compress ratio: 3.40 [ 600.883686] lustre_kcompr_15248: compr zstd(15) in 512kB chunks took 3770037 us (1 MB/s), compress ratio: 3.42 [ 604.846778] lustre_kcompr_15248: compr zstd(15) in 1024kB chunks took 3950395 us (1 MB/s), compress ratio: 3.43 [ 609.429681] lustre_kcompr_15248: compr zstd(15) in 2048kB chunks took 4575105 us (0 MB/s), compress ratio: 3.48 [ 614.621087] lustre_kcompr_15248: compr zstd(15) in 4096kB chunks took 5184478 us (0 MB/s), compress ratio: 3.56 [ 614.729699] lustre_kcompr_15248: decompr zstd(15) took 87303 us (12 MB/s) [ 614.742558] lustre_kcompr_15248: test_comp_compress_decompress(zstd,15) ret 0 [ 614.847943] lustre_kcompr_15248: acompr zstd(15) of 128kB chunks took 91706 us (1 MB/s), compress ratio: 23.92 [ 614.852683] lustre_kcompr_15248: adecompr zstd(15) took 585 us (8 MB/s) [ 614.857574] lustre_kcompr_15248: test_acomp_compress_decompress(zstd,15) ret 0 [ 614.888801] lustre_kcompr_15248: compr zstdfast(1) in 64kB chunks took 20500 us (195 MB/s), compress ratio: 2.47 [ 614.917419] lustre_kcompr_15248: compr zstdfast(1) in 128kB chunks took 24773 us (161 MB/s), compress ratio: 2.48 [ 614.941777] lustre_kcompr_15248: compr zstdfast(1) in 256kB chunks took 20788 us (192 MB/s), compress ratio: 2.53 [ 614.962075] lustre_kcompr_15248: compr zstdfast(1) in 512kB chunks took 16281 us (245 MB/s), compress ratio: 2.42 [ 614.988573] lustre_kcompr_15248: compr zstdfast(1) in 1024kB chunks took 22090 us (181 MB/s), compress ratio: 2.42 [ 615.016078] lustre_kcompr_15248: compr zstdfast(1) in 2048kB chunks took 22986 us (174 MB/s), compress ratio: 2.42 [ 615.041746] lustre_kcompr_15248: compr zstdfast(1) in 4096kB chunks took 21521 us (185 MB/s), compress ratio: 2.42 [ 615.056925] lustre_kcompr_15248: decompr zstdfast(1) took 4063 us (406 MB/s) [ 615.062472] lustre_kcompr_15248: test_comp_compress_decompress(zstdfast,1) ret 0 [ 615.069459] lustre_kcompr_15248: acompr zstdfast(1) of 128kB chunks took 593 us (210 MB/s), compress ratio: 17.28 [ 615.075686] lustre_kcompr_15248: adecompr zstdfast(1) took 578 us (12 MB/s) [ 615.083708] lustre_kcompr_15248: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 615.123273] lustre_kcompr_15248: compr zstdfast(5) in 64kB chunks took 26433 us (151 MB/s), compress ratio: 2.38 [ 615.150436] lustre_kcompr_15248: compr zstdfast(5) in 128kB chunks took 21220 us (188 MB/s), compress ratio: 2.38 [ 615.172921] lustre_kcompr_15248: compr zstdfast(5) in 256kB chunks took 15254 us (262 MB/s), compress ratio: 2.40 [ 615.199812] lustre_kcompr_15248: compr zstdfast(5) in 512kB chunks took 21027 us (190 MB/s), compress ratio: 2.36 [ 615.229090] lustre_kcompr_15248: compr zstdfast(5) in 1024kB chunks took 23607 us (169 MB/s), compress ratio: 2.36 [ 615.275452] lustre_kcompr_15248: compr zstdfast(5) in 2048kB chunks took 27485 us (145 MB/s), compress ratio: 2.36 [ 615.301847] lustre_kcompr_15248: compr zstdfast(5) in 4096kB chunks took 19433 us (205 MB/s), compress ratio: 2.36 [ 615.318682] lustre_kcompr_15248: decompr zstdfast(5) took 4182 us (403 MB/s) [ 615.329946] lustre_kcompr_15248: test_comp_compress_decompress(zstdfast,5) ret 0 [ 615.348046] lustre_kcompr_15248: acompr zstdfast(5) of 128kB chunks took 2424 us (51 MB/s), compress ratio: 16.12 [ 615.361334] lustre_kcompr_15248: adecompr zstdfast(5) took 353 us (21 MB/s) [ 615.367555] lustre_kcompr_15248: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 615.413522] lustre_kcompr_15248: compr zstdfast(12) in 64kB chunks took 4963 us (805 MB/s), compress ratio: 2.07 [ 615.445687] lustre_kcompr_15248: compr zstdfast(12) in 128kB chunks took 15606 us (256 MB/s), compress ratio: 2.07 [ 615.479623] lustre_kcompr_15248: compr zstdfast(12) in 256kB chunks took 13523 us (295 MB/s), compress ratio: 2.08 [ 615.512993] lustre_kcompr_15248: compr zstdfast(12) in 512kB chunks took 21510 us (185 MB/s), compress ratio: 2.07 [ 615.571276] lustre_kcompr_15248: compr zstdfast(12) in 1024kB chunks took 31356 us (127 MB/s), compress ratio: 2.07 [ 615.607494] lustre_kcompr_15248: compr zstdfast(12) in 2048kB chunks took 20448 us (195 MB/s), compress ratio: 2.07 [ 615.634867] lustre_kcompr_15248: compr zstdfast(12) in 4096kB chunks took 17700 us (225 MB/s), compress ratio: 2.08 [ 615.675837] lustre_kcompr_15248: decompr zstdfast(12) took 7055 us (272 MB/s) [ 615.706958] lustre_kcompr_15248: test_comp_compress_decompress(zstdfast,12) ret 0 [ 615.722271] lustre_kcompr_15248: acompr zstdfast(12) of 128kB chunks took 156 us (801 MB/s), compress ratio: 13.13 [ 615.748160] lustre_kcompr_15248: adecompr zstdfast(12) took 563 us (16 MB/s) [ 615.786392] lustre_kcompr_15248: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 615.828801] lustre_kcompr_15248: compr zstdfast(15) in 64kB chunks took 6973 us (573 MB/s), compress ratio: 1.82 [ 615.847365] lustre_kcompr_15248: compr zstdfast(15) in 128kB chunks took 10671 us (374 MB/s), compress ratio: 1.83 [ 615.882834] lustre_kcompr_15248: compr zstdfast(15) in 256kB chunks took 25523 us (156 MB/s), compress ratio: 1.83 [ 615.910263] lustre_kcompr_15248: compr zstdfast(15) in 512kB chunks took 9161 us (436 MB/s), compress ratio: 1.83 [ 615.928337] lustre_kcompr_15248: compr zstdfast(15) in 1024kB chunks took 8707 us (459 MB/s), compress ratio: 1.83 [ 615.945389] lustre_kcompr_15248: compr zstdfast(15) in 2048kB chunks took 7602 us (526 MB/s), compress ratio: 1.83 [ 615.971333] lustre_kcompr_15248: compr zstdfast(15) in 4096kB chunks took 7542 us (530 MB/s), compress ratio: 1.84 [ 615.989220] lustre_kcompr_15248: decompr zstdfast(15) took 4057 us (535 MB/s) [ 615.997431] lustre_kcompr_15248: test_comp_compress_decompress(zstdfast,15) ret 0 [ 616.008379] lustre_kcompr_15248: acompr zstdfast(15) of 128kB chunks took 135 us (925 MB/s), compress ratio: 10.73 [ 616.017888] lustre_kcompr_15248: adecompr zstdfast(15) took 105 us (110 MB/s) [ 616.038820] lustre_kcompr_15248: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 616.056394] lustre_kcompr_15248: SUCCESS [ 638.946531] Lustre: DEBUG MARKER: == sanity test complete, duration 403 sec ================ 12:40:02 (1789058402) [ 641.015445] Lustre: DEBUG MARKER: === sanity: start cleanup 12:40:04 (1789058404) === [ 645.133139] Lustre: DEBUG MARKER: === sanity: finish cleanup 12:40:08 (1789058408) === [ 647.826723] LustreError: 13326:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8af2485e2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 647.879794] Lustre: Unmounted lustre-client [ 685.226356] Key type lgssc unregistered [ 685.489716] LNet: 13918:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 685.503182] LNetError: 13918:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 685.539781] LNet: Removed LNI 192.168.206.6@tcp [ 686.209352] Key type .llcrypt unregistered [ 686.212786] Key type ._llcrypt unregistered