[ 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 483313473 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, 524580K 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.001012] APIC: Switch to symmetric I/O mode setup [ 0.002376] x2apic enabled [ 0.004004] Switched APIC routing to physical x2apic. [ 0.006014] kvm-guest: setup PV IPIs [ 0.009000] ..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.009021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010015] pid_max: default: 32768 minimum: 301 [ 0.012154] LSM: Security Framework initializing [ 0.013068] Yama: becoming mindful. [ 0.015036] SELinux: Initializing. [ 0.016066] *** VALIDATE selinux *** [ 0.024819] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.029387] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.030145] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031115] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032122] *** VALIDATE tmpfs *** [ 0.034393] *** VALIDATE proc *** [ 0.035266] *** VALIDATE cgroup *** [ 0.036011] *** VALIDATE cgroup2 *** [ 0.038032] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.039159] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.040009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.041030] Spectre V2 : User space: Vulnerable [ 0.042011] Speculative Store Bypass: Vulnerable [ 0.044964] debug: unmapping init [mem 0xffffffffa0a59000-0xffffffffa0a60fff] [ 0.046995] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.047726] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.048029] ... version: 2 [ 0.049018] ... bit width: 48 [ 0.050015] ... generic registers: 4 [ 0.051013] ... value mask: 0000ffffffffffff [ 0.052011] ... max period: 00007fffffffffff [ 0.053014] ... fixed-purpose events: 3 [ 0.054013] ... event mask: 000000070000000f [ 0.056275] rcu: Hierarchical SRCU implementation. [ 0.058514] smp: Bringing up secondary CPUs ... [ 0.059650] x86: Booting SMP configuration: [ 0.060030] .... node #0, CPUs: #1 #2 #3 [ 0.063744] smp: Brought up 1 node, 4 CPUs [ 0.065016] smpboot: Max logical packages: 1 [ 0.066024] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.269268] node 0 deferred pages initialised in 201ms [ 0.272118] devtmpfs: initialized [ 0.273376] x86/mm: Memory block size: 128MB [ 0.278411] gcov: version magic: 0x41383552 [ 0.281362] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.285152] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.287409] pinctrl core: initialized pinctrl subsystem [ 0.289228] [ 0.289943] ************************************************************* [ 0.292018] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.294016] ** ** [ 0.297022] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.299015] ** ** [ 0.301018] ** This means that this kernel is built to expose internal ** [ 0.304020] ** IOMMU data structures, which may compromise security on ** [ 0.306018] ** your system. ** [ 0.308015] ** ** [ 0.310018] ** If you see this message and you are not debugging the ** [ 0.313016] ** kernel, report this immediately to your vendor! ** [ 0.315014] ** ** [ 0.317015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.319019] ************************************************************* [ 0.321945] NET: Registered protocol family 16 [ 0.324509] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.326067] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.328086] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.332058] cpuidle: using governor menu [ 0.333756] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.336102] PCI: Using configuration type 1 for base access [ 0.338152] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.347166] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.350131] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.354121] cryptd: max_cpu_qlen set to 1000 [ 0.358366] ACPI: Added _OSI(Module Device) [ 0.359021] ACPI: Added _OSI(Processor Device) [ 0.361020] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.362038] ACPI: Added _OSI(Processor Aggregator Device) [ 0.367949] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.374226] ACPI: Interpreter enabled [ 0.375081] ACPI: PM: (supports S0 S3 S4 S5) [ 0.377022] ACPI: Using IOAPIC for interrupt routing [ 0.379137] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.382492] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.393458] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.395057] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.398044] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.401115] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.406497] acpiphp: Slot [2] registered [ 0.408166] acpiphp: Slot [5] registered [ 0.410184] acpiphp: Slot [6] registered [ 0.411156] acpiphp: Slot [3] registered [ 0.413184] acpiphp: Slot [4] registered [ 0.414134] acpiphp: Slot [7] registered [ 0.415139] acpiphp: Slot [8] registered [ 0.417128] acpiphp: Slot [9] registered [ 0.418129] acpiphp: Slot [10] registered [ 0.420164] acpiphp: Slot [11] registered [ 0.421185] acpiphp: Slot [12] registered [ 0.423169] acpiphp: Slot [13] registered [ 0.424157] acpiphp: Slot [14] registered [ 0.426154] acpiphp: Slot [15] registered [ 0.427127] acpiphp: Slot [16] registered [ 0.429130] acpiphp: Slot [17] registered [ 0.430132] acpiphp: Slot [18] registered [ 0.432164] acpiphp: Slot [19] registered [ 0.433144] acpiphp: Slot [20] registered [ 0.435159] acpiphp: Slot [21] registered [ 0.436152] acpiphp: Slot [22] registered [ 0.438139] acpiphp: Slot [23] registered [ 0.440134] acpiphp: Slot [24] registered [ 0.441157] acpiphp: Slot [25] registered [ 0.443129] acpiphp: Slot [26] registered [ 0.444118] acpiphp: Slot [27] registered [ 0.446126] acpiphp: Slot [28] registered [ 0.447103] acpiphp: Slot [29] registered [ 0.449136] acpiphp: Slot [30] registered [ 0.450121] acpiphp: Slot [31] registered [ 0.451114] PCI host bridge to bus 0000:00 [ 0.453032] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.455040] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.457034] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.459029] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.461037] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.464040] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.465186] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.468013] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.472520] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.479020] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.483065] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.486027] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.488025] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.490023] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.492661] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.496781] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.498046] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.500769] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.505013] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.515689] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.519021] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.524056] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.530023] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.538027] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.551025] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.560117] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.567023] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.574028] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.597028] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.610000] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.613409] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.615409] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.618440] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.620219] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.624130] iommu: Default domain type: Passthrough [ 0.626308] SCSI subsystem initialized [ 0.628179] ACPI: bus type USB registered [ 0.629142] usbcore: registered new interface driver usbfs [ 0.631121] usbcore: registered new interface driver hub [ 0.633117] usbcore: registered new device driver usb [ 0.635204] pps_core: LinuxPPS API ver. 1 registered [ 0.636013] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.639082] PTP clock support registered [ 0.642079] EDAC MC: Ver: 3.0.0 [ 0.644185] PCI: Using ACPI for IRQ routing [ 0.647510] NetLabel: Initializing [ 0.649034] NetLabel: domain hash size = 128 [ 0.651017] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.654172] NetLabel: unlabeled traffic allowed by default [ 0.657109] vgaarb: loaded [ 0.658360] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.659014] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.662370] clocksource: Switched to clocksource kvm-clock [ 0.823037] VFS: Disk quotas dquot_6.6.0 [ 0.824874] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.827519] *** VALIDATE ramfs *** [ 0.828795] *** VALIDATE hugetlbfs *** [ 0.830215] pnp: PnP ACPI init [ 0.832836] pnp: PnP ACPI: found 6 devices [ 0.857143] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.860762] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.862917] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.865325] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.867918] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.870276] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.873431] NET: Registered protocol family 2 [ 0.876136] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.881736] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.885702] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.891473] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.895661] TCP: Hash tables configured (established 65536 bind 65536) [ 0.898841] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.902064] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.905716] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.908714] NET: Registered protocol family 1 [ 0.911431] RPC: Registered named UNIX socket transport module. [ 0.914340] RPC: Registered udp transport module. [ 0.916105] RPC: Registered tcp transport module. [ 0.917946] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.920510] NET: Registered protocol family 44 [ 0.922431] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.924728] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.927424] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.929874] PCI: CLS 0 bytes, default 64 [ 0.931870] Unpacking initramfs... [ 2.336067] debug: unmapping init [mem 0xffff9f8cfcc64000-0xffff9f8cfffcffff] [ 2.340245] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.342475] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.344705] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.867204] Initialise system trusted keyrings [ 2.868675] Key type blacklist registered [ 2.870393] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.879184] zbud: loaded [ 2.882248] *** VALIDATE nfs *** [ 2.883320] *** VALIDATE nfs4 *** [ 2.884647] pstore: using deflate compression [ 2.887740] Platform Keyring initialized [ 2.993110] NET: Registered protocol family 38 [ 2.995952] Key type asymmetric registered [ 2.997198] Asymmetric key parser 'x509' registered [ 2.998973] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.001406] io scheduler mq-deadline registered [ 3.002726] io scheduler kyber registered [ 3.004063] io scheduler bfq registered [ 3.005705] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.008261] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.010675] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.013186] ACPI: Power Button [PWRF] [ 3.018306] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.024059] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.034485] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.062045] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.090198] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.094721] Non-volatile memory driver v1.3 [ 3.096284] Linux agpgart interface v0.103 [ 3.128988] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 3.132181] vda: detected capacity change from 0 to 73097216 [ 3.146617] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.149539] vdb: detected capacity change from 0 to 1073741824 [ 3.159357] libphy: Fixed MDIO Bus: probed [ 3.166195] usbcore: registered new interface driver usbserial_generic [ 3.168535] usbserial: USB Serial support registered for generic [ 3.170578] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.174358] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.175831] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.178134] mousedev: PS/2 mouse device common for all mice [ 3.181128] rtc_cmos 00:05: RTC can wake from S4 [ 3.183435] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.184702] rtc_cmos 00:05: registered as rtc0 [ 3.189089] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.189440] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.192325] intel_pstate: CPU model not supported [ 3.196358] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.201276] hid: raw HID events driver (C) Jiri Kosina [ 3.203363] usbcore: registered new interface driver usbhid [ 3.206018] usbhid: USB HID core driver [ 3.207615] drop_monitor: Initializing network drop monitor service [ 3.209938] Initializing XFRM netlink socket [ 3.212396] NET: Registered protocol family 10 [ 3.216590] Segment Routing with IPv6 [ 3.217820] NET: Registered protocol family 17 [ 3.219692] mpls_gso: MPLS GSO support [ 3.225370] RAS: Correctable Errors collector initialized. [ 3.227188] AVX version of gcm_enc/dec engaged. [ 3.228538] AES CTR mode by8 optimization enabled [ 3.300630] sched_clock: Marking stable (3300572314, 0)->(4208154221, -907581907) [ 3.303134] registered taskstats version 1 [ 3.304547] Loading compiled-in X.509 certificates [ 3.305819] zswap: loaded using pool lzo/zbud [ 3.325861] Key type big_key registered [ 3.334920] Key type encrypted registered [ 3.336594] ima: No TPM chip found, activating TPM-bypass! [ 3.338629] ima: Allocated hash algorithm: sha1 [ 3.339834] ima: No architecture policies found [ 3.341585] evm: Initialising EVM extended attributes: [ 3.343037] evm: security.selinux [ 3.343845] evm: security.ima [ 3.344620] evm: security.capability [ 3.345505] evm: HMAC attrs: 0x1 [ 3.348673] rtc_cmos 00:05: setting system clock to 2026-09-10 16:35:57 UTC (1789058157) [ 3.353964] debug: unmapping init [mem 0xffffffffa1a03000-0xffffffffa1bfffff] [ 3.356128] debug: unmapping init [mem 0xffffffffa0782000-0xffffffffa0a58fff] [ 3.365097] Write protecting the kernel read-only data: 28672k [ 3.367511] debug: unmapping init [mem 0xffffffff9ee03000-0xffffffff9effffff] [ 3.369338] debug: unmapping init [mem 0xffffffff9f714000-0xffffffff9f7fffff] [ 3.404588] 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.413382] systemd[1]: Detected virtualization kvm. [ 3.415151] systemd[1]: Detected architecture x86-64. [ 3.417067] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.439585] systemd[1]: No hostname configured. [ 3.441153] systemd[1]: Set hostname to . [ 3.443217] random: systemd: uninitialized urandom read (16 bytes read) [ 3.445406] systemd[1]: Initializing machine ID from random generator. [ 3.565476] random: systemd: uninitialized urandom read (16 bytes read) [ 3.568074] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.572624] random: systemd: uninitialized urandom read (16 bytes read) [ 3.575833] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.580485] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ OK ] Reached target Local File Systems. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. [ OK ] Listening on udev Kernel Socket. Starting Setup Virtual Console... [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Swap. Starting Create Volatile Files and Directories... [ OK ] Reached target Paths. Starting Apply Kernel Variables... [ OK ] Started Memstrack Anylazing Service. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... 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.133678] device-mapper: uevent: version 1.0.3 [ 4.136476] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.807729] virtio_net virtio0 ens2: renamed from eth0 [ 4.852242] scsi host0: ata_piix [ 4.886552] scsi host1: ata_piix [ 4.893782] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.896439] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.549763] dracut-initqueue[579]: RTNETLINK answers: File exists [ 8.552166] random: fast init done [ 9.856809] random: crng init done [ 9.858232] 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.173873] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ 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 Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.225154] printk: systemd: 24 output lines suppressed due to ratelimiting [ 11.456919] SELinux: Disabled at runtime. [ 11.515843] 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.522868] systemd[1]: Detected virtualization kvm. [ 11.524533] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.955471] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.959292] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.963604] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.968251] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.974583] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.981538] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.985870] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. Starting Remount Root and Kernel File Systems... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. Mounting Huge Pages File System... Starting Create list of required st…ce nodes for the current kernel... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Apply Kernel Variables... [ OK ] Listening on RPCbind Server Activation Socket. Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on udev Kernel Socket. Mounting POSIX Message Queue File System... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ 12.093257] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Mounting Kernel Debug File System... [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-getty.slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 12.408621] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.667317] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.742682] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.810215] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.822829] EDAC sbridge: Ver: 1.1.2 [ 13.899694] Key type dns_resolver registered [ 14.200105] NFS: Registering the id_resolver key type [ 14.202204] Key type id_resolver registered [ 14.203719] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Login Service. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ 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 Crash recovery kernel arming... Starting Notify NFS peers of a restart... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting 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 Authorization Manager. [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg247-client login: [ 41.236403] libcfs: loading out-of-tree module taints kernel. [ 41.320812] Key type ._llcrypt registered [ 41.322604] Key type .llcrypt registered [ 41.513674] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 41.521745] alg: No test for adler32 (adler32-zlib) [ 42.589901] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 42.905419] LNet: Added LNI 192.168.202.47@tcp [8/256/0/180] [ 44.535170] Key type lgssc registered [ 45.246558] Lustre: Echo OBD driver; http://www.lustre.org/ [ 47.885966] alg: No test for zstdfast (zstdfast-lustre-generic) [ 47.893754] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 83.122126] hrtimer: interrupt took 11105952 ns [ 225.781529] Lustre: Mounted lustre-client [ 231.530465] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 249.748197] Lustre: DEBUG MARKER: oleg247-client.virtnet: executing check_logdir /tmp/testlogs/ [ 251.360791] Lustre: lustre-OST0000-osc-ffff9f8d48feb800: disconnect after 23s idle [ 255.567867] Lustre: DEBUG MARKER: oleg247-client.virtnet: executing yml_node [ 260.811501] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 264.191680] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 267.054577] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 268.992258] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:40:21 EDT 2026 [ 294.351549] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 296.553478] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 298.708994] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a [ 300.780479] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51c 51e 834 [ 302.788900] Lustre: DEBUG MARKER: === sanity: start setup 12:40:55 (1789058455) === [ 308.264183] Lustre: DEBUG MARKER: oleg247-client.virtnet: executing check_config_client /mnt/lustre [ 340.700806] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 359.919885] Lustre: DEBUG MARKER: === sanity: finish setup 12:41:52 (1789058512) === [ 367.600784] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:42:00 (1789058520) [ 368.610566] lustre_kcompr_14914: ***** [ 368.613970] lustre_kcompr_14914: (de)compression test on random binary data [ 368.625520] lustre_kcompr_14914: ***** [ 368.657496] lustre_kcompr_14914: compr lz4(1) in 64kB chunks took 10778 us (371 MB/s), compress ratio: 96.94 [ 368.676763] lustre_kcompr_14914: compr lz4(1) in 128kB chunks took 3872 us (1033 MB/s), compress ratio: 101.14 [ 368.696369] lustre_kcompr_14914: compr lz4(1) in 256kB chunks took 3542 us (1129 MB/s), compress ratio: 104.13 [ 368.713804] lustre_kcompr_14914: compr lz4(1) in 512kB chunks took 2888 us (1385 MB/s), compress ratio: 105.52 [ 368.727795] lustre_kcompr_14914: compr lz4(1) in 1024kB chunks took 1302 us (3072 MB/s), compress ratio: 106.61 [ 368.747173] lustre_kcompr_14914: compr lz4(1) in 2048kB chunks took 4207 us (950 MB/s), compress ratio: 106.69 [ 368.760462] lustre_kcompr_14914: compr lz4(1) in 4096kB chunks took 7468 us (535 MB/s), compress ratio: 106.45 [ 368.784624] lustre_kcompr_14914: decompr lz4(1) took 4292 us (8 MB/s) [ 368.794922] lustre_kcompr_14914: test_comp_compress_decompress(lz4,1) ret 0 [ 368.810332] lustre_kcompr_14914: acompr lz4(1) of 128kB chunks took 92 us (1358 MB/s), compress ratio: 92.82 [ 368.822454] lustre_kcompr_14914: adecompr lz4(1) took 91 us (14 MB/s) [ 368.863374] lustre_kcompr_14914: test_acomp_compress_decompress(lz4,1) ret 0 [ 368.910461] lustre_kcompr_14914: compr lz4(4) in 64kB chunks took 1874 us (2134 MB/s), compress ratio: 82.19 [ 368.925379] lustre_kcompr_14914: compr lz4(4) in 128kB chunks took 3603 us (1110 MB/s), compress ratio: 92.07 [ 368.939553] lustre_kcompr_14914: compr lz4(4) in 256kB chunks took 1933 us (2069 MB/s), compress ratio: 98.34 [ 368.953647] lustre_kcompr_14914: compr lz4(4) in 512kB chunks took 2037 us (1963 MB/s), compress ratio: 101.89 [ 368.978232] lustre_kcompr_14914: compr lz4(4) in 1024kB chunks took 6449 us (620 MB/s), compress ratio: 103.97 [ 368.993673] lustre_kcompr_14914: compr lz4(4) in 2048kB chunks took 2459 us (1626 MB/s), compress ratio: 104.78 [ 368.999790] lustre_kcompr_14914: compr lz4(4) in 4096kB chunks took 1190 us (3361 MB/s), compress ratio: 105.71 [ 369.017810] lustre_kcompr_14914: decompr lz4(4) took 2819 us (13 MB/s) [ 369.022627] lustre_kcompr_14914: test_comp_compress_decompress(lz4,4) ret 0 [ 369.027539] lustre_kcompr_14914: acompr lz4(4) of 128kB chunks took 96 us (1302 MB/s), compress ratio: 84.83 [ 369.035357] lustre_kcompr_14914: adecompr lz4(4) took 94 us (15 MB/s) [ 369.063218] lustre_kcompr_14914: test_acomp_compress_decompress(lz4,4) ret 0 [ 369.093505] lustre_kcompr_14914: compr lz4(9) in 64kB chunks took 4699 us (851 MB/s), compress ratio: 61.09 [ 369.102892] lustre_kcompr_14914: compr lz4(9) in 128kB chunks took 1387 us (2883 MB/s), compress ratio: 75.05 [ 369.120580] lustre_kcompr_14914: compr lz4(9) in 256kB chunks took 1275 us (3137 MB/s), compress ratio: 86.12 [ 369.142166] lustre_kcompr_14914: compr lz4(9) in 512kB chunks took 6568 us (609 MB/s), compress ratio: 93.21 [ 369.159424] lustre_kcompr_14914: compr lz4(9) in 1024kB chunks took 5030 us (795 MB/s), compress ratio: 97.77 [ 369.172635] lustre_kcompr_14914: compr lz4(9) in 2048kB chunks took 4376 us (914 MB/s), compress ratio: 99.43 [ 369.206238] lustre_kcompr_14914: compr lz4(9) in 4096kB chunks took 13657 us (292 MB/s), compress ratio: 100.25 [ 369.242311] lustre_kcompr_14914: decompr lz4(9) took 6417 us (6 MB/s) [ 369.256083] lustre_kcompr_14914: test_comp_compress_decompress(lz4,9) ret 0 [ 369.261688] lustre_kcompr_14914: acompr lz4(9) of 128kB chunks took 99 us (1262 MB/s), compress ratio: 73.67 [ 369.275908] lustre_kcompr_14914: adecompr lz4(9) took 100 us (16 MB/s) [ 369.298271] lustre_kcompr_14914: test_acomp_compress_decompress(lz4,9) ret 0 [ 369.345254] lustre_kcompr_14914: compr lz4(15) in 64kB chunks took 5836 us (685 MB/s), compress ratio: 29.43 [ 369.356259] lustre_kcompr_14914: compr lz4(15) in 128kB chunks took 2365 us (1691 MB/s), compress ratio: 43.96 [ 369.367254] lustre_kcompr_14914: compr lz4(15) in 256kB chunks took 2634 us (1518 MB/s), compress ratio: 60.03 [ 369.382464] lustre_kcompr_14914: compr lz4(15) in 512kB chunks took 1664 us (2403 MB/s), compress ratio: 72.77 [ 369.392045] lustre_kcompr_14914: compr lz4(15) in 1024kB chunks took 2594 us (1542 MB/s), compress ratio: 80.52 [ 369.399064] lustre_kcompr_14914: compr lz4(15) in 2048kB chunks took 1368 us (2923 MB/s), compress ratio: 85.04 [ 369.405143] lustre_kcompr_14914: compr lz4(15) in 4096kB chunks took 1347 us (2969 MB/s), compress ratio: 88.37 [ 369.417581] lustre_kcompr_14914: decompr lz4(15) took 2582 us (17 MB/s) [ 369.421316] lustre_kcompr_14914: test_comp_compress_decompress(lz4,15) ret 0 [ 369.426425] lustre_kcompr_14914: acompr lz4(15) of 128kB chunks took 90 us (1388 MB/s), compress ratio: 42.94 [ 369.430974] lustre_kcompr_14914: adecompr lz4(15) took 102 us (28 MB/s) [ 369.435779] lustre_kcompr_14914: test_acomp_compress_decompress(lz4,15) ret 0 [ 369.474457] lustre_kcompr_14914: compr lz4hc(1) in 64kB chunks took 29614 us (135 MB/s), compress ratio: 97.18 [ 369.508963] lustre_kcompr_14914: compr lz4hc(1) in 128kB chunks took 29463 us (135 MB/s), compress ratio: 103.07 [ 369.531760] lustre_kcompr_14914: compr lz4hc(1) in 256kB chunks took 19114 us (209 MB/s), compress ratio: 106.28 [ 369.586943] lustre_kcompr_14914: compr lz4hc(1) in 512kB chunks took 49361 us (81 MB/s), compress ratio: 107.97 [ 369.627479] lustre_kcompr_14914: compr lz4hc(1) in 1024kB chunks took 30298 us (132 MB/s), compress ratio: 108.84 [ 369.667945] lustre_kcompr_14914: compr lz4hc(1) in 2048kB chunks took 33758 us (118 MB/s), compress ratio: 109.27 [ 369.706432] lustre_kcompr_14914: compr lz4hc(1) in 4096kB chunks took 31949 us (125 MB/s), compress ratio: 109.49 [ 369.719663] lustre_kcompr_14914: decompr lz4hc(1) took 1794 us (20 MB/s) [ 369.724584] lustre_kcompr_14914: test_comp_compress_decompress(lz4hc,1) ret 0 [ 369.730450] lustre_kcompr_14914: acompr lz4hc(1) of 128kB chunks took 969 us (128 MB/s), compress ratio: 99.59 [ 369.736126] lustre_kcompr_14914: adecompr lz4hc(1) took 163 us (7 MB/s) [ 369.742140] lustre_kcompr_14914: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 369.794724] lustre_kcompr_14914: compr lz4hc(3) in 64kB chunks took 40254 us (99 MB/s), compress ratio: 97.70 [ 369.878065] lustre_kcompr_14914: compr lz4hc(3) in 128kB chunks took 75252 us (53 MB/s), compress ratio: 103.65 [ 369.942189] lustre_kcompr_14914: compr lz4hc(3) in 256kB chunks took 54268 us (73 MB/s), compress ratio: 106.90 [ 370.000866] lustre_kcompr_14914: compr lz4hc(3) in 512kB chunks took 51329 us (77 MB/s), compress ratio: 108.60 [ 370.113507] lustre_kcompr_14914: compr lz4hc(3) in 1024kB chunks took 94401 us (42 MB/s), compress ratio: 109.47 [ 370.229846] lustre_kcompr_14914: compr lz4hc(3) in 2048kB chunks took 101880 us (39 MB/s), compress ratio: 109.90 [ 370.309668] lustre_kcompr_14914: compr lz4hc(3) in 4096kB chunks took 66019 us (60 MB/s), compress ratio: 110.11 [ 370.326260] lustre_kcompr_14914: decompr lz4hc(3) took 1960 us (18 MB/s) [ 370.332895] lustre_kcompr_14914: test_comp_compress_decompress(lz4hc,3) ret 0 [ 370.341740] lustre_kcompr_14914: acompr lz4hc(3) of 128kB chunks took 1930 us (64 MB/s), compress ratio: 99.82 [ 370.349210] lustre_kcompr_14914: adecompr lz4hc(3) took 93 us (13 MB/s) [ 370.360788] lustre_kcompr_14914: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 371.471590] lustre_kcompr_14914: compr lz4hc(8) in 64kB chunks took 1095528 us (3 MB/s), compress ratio: 104.22 [ 372.221180] lustre_kcompr_14914: compr lz4hc(8) in 128kB chunks took 743266 us (5 MB/s), compress ratio: 111.23 [ 373.316564] lustre_kcompr_14914: compr lz4hc(8) in 256kB chunks took 1091561 us (3 MB/s), compress ratio: 115.22 [ 374.274837] lustre_kcompr_14914: compr lz4hc(8) in 512kB chunks took 944652 us (4 MB/s), compress ratio: 117.25 [ 374.850418] lustre_kcompr_14914: compr lz4hc(8) in 1024kB chunks took 567779 us (7 MB/s), compress ratio: 118.32 [ 375.896392] lustre_kcompr_14914: compr lz4hc(8) in 2048kB chunks took 1036970 us (3 MB/s), compress ratio: 118.83 [ 377.148456] lustre_kcompr_14914: compr lz4hc(8) in 4096kB chunks took 1241034 us (3 MB/s), compress ratio: 119.10 [ 377.177936] lustre_kcompr_14914: decompr lz4hc(8) took 8038 us (4 MB/s) [ 377.186301] lustre_kcompr_14914: test_comp_compress_decompress(lz4hc,8) ret 0 [ 377.232909] lustre_kcompr_14914: acompr lz4hc(8) of 128kB chunks took 37766 us (3 MB/s), compress ratio: 107.08 [ 377.243838] lustre_kcompr_14914: adecompr lz4hc(8) took 107 us (10 MB/s) [ 377.261228] lustre_kcompr_14914: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 378.843185] lustre_kcompr_14914: compr lz4hc(15) in 64kB chunks took 1541596 us (2 MB/s), compress ratio: 104.68 [ 380.446201] lustre_kcompr_14914: compr lz4hc(15) in 128kB chunks took 1594219 us (2 MB/s), compress ratio: 112.09 [ 382.041198] lustre_kcompr_14914: compr lz4hc(15) in 256kB chunks took 1588520 us (2 MB/s), compress ratio: 116.32 [ 383.467915] lustre_kcompr_14914: compr lz4hc(15) in 512kB chunks took 1416773 us (2 MB/s), compress ratio: 118.56 [ 384.479488] Lustre: lustre-OST0001-osc-ffff9f8d48feb800: disconnect after 23s idle [ 384.482236] Lustre: Skipped 1 previous similar message [ 384.739275] lustre_kcompr_14914: compr lz4hc(15) in 1024kB chunks took 1267419 us (3 MB/s), compress ratio: 119.71 [ 385.729613] lustre_kcompr_14914: compr lz4hc(15) in 2048kB chunks took 983009 us (4 MB/s), compress ratio: 120.29 [ 386.714358] lustre_kcompr_14914: compr lz4hc(15) in 4096kB chunks took 980291 us (4 MB/s), compress ratio: 120.57 [ 386.732262] lustre_kcompr_14914: decompr lz4hc(15) took 2454 us (13 MB/s) [ 386.736613] lustre_kcompr_14914: test_comp_compress_decompress(lz4hc,15) ret 0 [ 386.825384] lustre_kcompr_14914: acompr lz4hc(15) of 128kB chunks took 83620 us (1 MB/s), compress ratio: 107.08 [ 386.838578] lustre_kcompr_14914: adecompr lz4hc(15) took 83 us (14 MB/s) [ 386.882258] lustre_kcompr_14914: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 386.892852] lustre_kcompr_14914: compr lzo(-1) in 64kB chunks took 1949 us (2052 MB/s), compress ratio: 81.91 [ 386.912795] lustre_kcompr_14914: compr lzo(-1) in 128kB chunks took 5022 us (796 MB/s), compress ratio: 86.38 [ 386.932001] lustre_kcompr_14914: compr lzo(-1) in 256kB chunks took 1843 us (2170 MB/s), compress ratio: 86.61 [ 386.960541] lustre_kcompr_14914: compr lzo(-1) in 512kB chunks took 11498 us (347 MB/s), compress ratio: 88.41 [ 386.972071] lustre_kcompr_14914: compr lzo(-1) in 1024kB chunks took 2668 us (1499 MB/s), compress ratio: 88.28 [ 386.994711] lustre_kcompr_14914: compr lzo(-1) in 2048kB chunks took 7381 us (541 MB/s), compress ratio: 88.80 [ 387.009547] lustre_kcompr_14914: compr lzo(-1) in 4096kB chunks took 2881 us (1388 MB/s), compress ratio: 89.04 [ 387.043351] lustre_kcompr_14914: decompr lzo(-1) took 1458 us (30 MB/s) [ 387.051377] lustre_kcompr_14914: test_comp_compress_decompress(lzo,-1) ret 0 [ 387.054996] lustre_kcompr_14914: acompr lzo(-1) of 128kB chunks took 103 us (1213 MB/s), compress ratio: 81.41 [ 387.059210] lustre_kcompr_14914: adecompr lzo(-1) took 119 us (12 MB/s) [ 387.068734] lustre_kcompr_14914: test_acomp_compress_decompress(lzo,-1) ret 0 [ 387.365491] lustre_kcompr_14914: compr deflate(1) in 64kB chunks took 288144 us (13 MB/s), compress ratio: 97.54 [ 387.908567] lustre_kcompr_14914: compr deflate(1) in 128kB chunks took 531463 us (7 MB/s), compress ratio: 107.80 [ 388.656273] lustre_kcompr_14914: compr deflate(1) in 256kB chunks took 728104 us (5 MB/s), compress ratio: 114.26 [ 389.309978] lustre_kcompr_14914: compr deflate(1) in 512kB chunks took 631738 us (6 MB/s), compress ratio: 118.05 [ 389.918394] lustre_kcompr_14914: compr deflate(1) in 1024kB chunks took 599996 us (6 MB/s), compress ratio: 119.92 [ 390.662185] lustre_kcompr_14914: compr deflate(1) in 2048kB chunks took 734784 us (5 MB/s), compress ratio: 120.88 [ 391.455663] lustre_kcompr_14914: compr deflate(1) in 4096kB chunks took 782719 us (5 MB/s), compress ratio: 121.16 [ 391.498300] lustre_kcompr_14914: decompr deflate(1) took 11786 us (2 MB/s) [ 391.525928] lustre_kcompr_14914: test_comp_compress_decompress(deflate,1) ret 0 [ 391.568469] lustre_kcompr_14914: acompr deflate(1) of 128kB chunks took 27014 us (4 MB/s), compress ratio: 103.69 [ 391.585479] lustre_kcompr_14914: adecompr deflate(1) took 253 us (4 MB/s) [ 391.605864] lustre_kcompr_14914: test_acomp_compress_decompress(deflate,1) ret 0 [ 392.457351] lustre_kcompr_14914: compr deflate(6) in 64kB chunks took 817577 us (4 MB/s), compress ratio: 97.54 [ 393.193688] lustre_kcompr_14914: compr deflate(6) in 128kB chunks took 727099 us (5 MB/s), compress ratio: 107.80 [ 393.877730] lustre_kcompr_14914: compr deflate(6) in 256kB chunks took 677797 us (5 MB/s), compress ratio: 114.26 [ 394.477679] lustre_kcompr_14914: compr deflate(6) in 512kB chunks took 583938 us (6 MB/s), compress ratio: 118.05 [ 395.085623] lustre_kcompr_14914: compr deflate(6) in 1024kB chunks took 589023 us (6 MB/s), compress ratio: 119.92 [ 395.677693] lustre_kcompr_14914: compr deflate(6) in 2048kB chunks took 583208 us (6 MB/s), compress ratio: 120.88 [ 396.187502] lustre_kcompr_14914: compr deflate(6) in 4096kB chunks took 502992 us (7 MB/s), compress ratio: 121.16 [ 396.224195] lustre_kcompr_14914: decompr deflate(6) took 11070 us (2 MB/s) [ 396.247538] lustre_kcompr_14914: test_comp_compress_decompress(deflate,6) ret 0 [ 396.280909] lustre_kcompr_14914: acompr deflate(6) of 128kB chunks took 20959 us (5 MB/s), compress ratio: 103.69 [ 396.291920] lustre_kcompr_14914: adecompr deflate(6) took 1945 us (0 MB/s) [ 396.363819] lustre_kcompr_14914: test_acomp_compress_decompress(deflate,6) ret 0 [ 397.295937] lustre_kcompr_14914: compr deflate(9) in 64kB chunks took 895000 us (4 MB/s), compress ratio: 97.54 [ 397.835790] lustre_kcompr_14914: compr deflate(9) in 128kB chunks took 516452 us (7 MB/s), compress ratio: 107.80 [ 398.463855] lustre_kcompr_14914: compr deflate(9) in 256kB chunks took 618062 us (6 MB/s), compress ratio: 114.26 [ 399.253909] lustre_kcompr_14914: compr deflate(9) in 512kB chunks took 781560 us (5 MB/s), compress ratio: 118.05 [ 400.280576] lustre_kcompr_14914: compr deflate(9) in 1024kB chunks took 1016117 us (3 MB/s), compress ratio: 119.92 [ 400.925470] lustre_kcompr_14914: compr deflate(9) in 2048kB chunks took 618226 us (6 MB/s), compress ratio: 120.88 [ 401.293996] lustre_kcompr_14914: compr deflate(9) in 4096kB chunks took 361213 us (11 MB/s), compress ratio: 121.16 [ 401.313580] lustre_kcompr_14914: decompr deflate(9) took 4738 us (6 MB/s) [ 401.319102] lustre_kcompr_14914: test_comp_compress_decompress(deflate,9) ret 0 [ 401.334222] lustre_kcompr_14914: acompr deflate(9) of 128kB chunks took 9413 us (13 MB/s), compress ratio: 103.69 [ 401.341394] lustre_kcompr_14914: adecompr deflate(9) took 180 us (6 MB/s) [ 401.353319] lustre_kcompr_14914: test_acomp_compress_decompress(deflate,9) ret 0 [ 401.377179] lustre_kcompr_14914: compr zstd(0) in 64kB chunks took 8525 us (469 MB/s), compress ratio: 158.52 [ 401.399807] lustre_kcompr_14914: compr zstd(0) in 128kB chunks took 16430 us (243 MB/s), compress ratio: 191.25 [ 401.422610] lustre_kcompr_14914: compr zstd(0) in 256kB chunks took 16759 us (238 MB/s), compress ratio: 204.03 [ 401.450328] lustre_kcompr_14914: compr zstd(0) in 512kB chunks took 22954 us (174 MB/s), compress ratio: 211.54 [ 401.472862] lustre_kcompr_14914: compr zstd(0) in 1024kB chunks took 10888 us (367 MB/s), compress ratio: 213.42 [ 401.508617] lustre_kcompr_14914: compr zstd(0) in 2048kB chunks took 10934 us (365 MB/s), compress ratio: 214.89 [ 401.531866] lustre_kcompr_14914: compr zstd(0) in 4096kB chunks took 9026 us (443 MB/s), compress ratio: 215.49 [ 401.563762] lustre_kcompr_14914: decompr zstd(0) took 2924 us (6 MB/s) [ 401.582934] lustre_kcompr_14914: test_comp_compress_decompress(zstd,0) ret 0 [ 401.592490] lustre_kcompr_14914: acompr zstd(0) of 128kB chunks took 236 us (529 MB/s), compress ratio: 178.08 [ 401.606357] lustre_kcompr_14914: adecompr zstd(0) took 790 us (0 MB/s) [ 401.626715] lustre_kcompr_14914: test_acomp_compress_decompress(zstd,0) ret 0 [ 401.660153] lustre_kcompr_14914: compr zstd(1) in 64kB chunks took 9377 us (426 MB/s), compress ratio: 157.60 [ 401.669483] lustre_kcompr_14914: compr zstd(1) in 128kB chunks took 2257 us (1772 MB/s), compress ratio: 188.76 [ 401.704663] lustre_kcompr_14914: compr zstd(1) in 256kB chunks took 11045 us (362 MB/s), compress ratio: 200.43 [ 401.729294] lustre_kcompr_14914: compr zstd(1) in 512kB chunks took 7620 us (524 MB/s), compress ratio: 207.92 [ 401.759474] lustre_kcompr_14914: compr zstd(1) in 1024kB chunks took 8793 us (454 MB/s), compress ratio: 209.93 [ 401.775582] lustre_kcompr_14914: compr zstd(1) in 2048kB chunks took 6403 us (624 MB/s), compress ratio: 210.74 [ 401.799919] lustre_kcompr_14914: compr zstd(1) in 4096kB chunks took 8785 us (455 MB/s), compress ratio: 211.80 [ 401.846384] lustre_kcompr_14914: decompr zstd(1) took 6569 us (2 MB/s) [ 401.886317] lustre_kcompr_14914: test_comp_compress_decompress(zstd,1) ret 0 [ 401.901832] lustre_kcompr_14914: acompr zstd(1) of 128kB chunks took 185 us (675 MB/s), compress ratio: 178.08 [ 401.914038] lustre_kcompr_14914: adecompr zstd(1) took 201 us (3 MB/s) [ 401.933799] lustre_kcompr_14914: test_acomp_compress_decompress(zstd,1) ret 0 [ 402.398148] lustre_kcompr_14914: compr zstd(10) in 64kB chunks took 444277 us (9 MB/s), compress ratio: 160.49 [ 402.791276] lustre_kcompr_14914: compr zstd(10) in 128kB chunks took 376287 us (10 MB/s), compress ratio: 183.17 [ 403.184553] lustre_kcompr_14914: compr zstd(10) in 256kB chunks took 378639 us (10 MB/s), compress ratio: 194.50 [ 403.487108] lustre_kcompr_14914: compr zstd(10) in 512kB chunks took 296507 us (13 MB/s), compress ratio: 215.74 [ 404.008494] lustre_kcompr_14914: compr zstd(10) in 1024kB chunks took 511456 us (7 MB/s), compress ratio: 220.04 [ 404.673781] lustre_kcompr_14914: compr zstd(10) in 2048kB chunks took 650951 us (6 MB/s), compress ratio: 221.86 [ 404.802440] lustre_kcompr_14914: compr zstd(10) in 4096kB chunks took 110754 us (36 MB/s), compress ratio: 223.22 [ 404.830138] lustre_kcompr_14914: decompr zstd(10) took 5874 us (3 MB/s) [ 404.844954] lustre_kcompr_14914: test_comp_compress_decompress(zstd,10) ret 0 [ 404.867895] lustre_kcompr_14914: acompr zstd(10) of 128kB chunks took 10636 us (11 MB/s), compress ratio: 171.33 [ 404.878579] lustre_kcompr_14914: adecompr zstd(10) took 124 us (5 MB/s) [ 404.957420] lustre_kcompr_14914: test_acomp_compress_decompress(zstd,10) ret 0 [ 406.169662] lustre_kcompr_14914: compr zstd(15) in 64kB chunks took 1163716 us (3 MB/s), compress ratio: 169.03 [ 407.595923] lustre_kcompr_14914: compr zstd(15) in 128kB chunks took 1415329 us (2 MB/s), compress ratio: 193.85 [ 408.134558] lustre_kcompr_14914: compr zstd(15) in 256kB chunks took 534837 us (7 MB/s), compress ratio: 208.09 [ 408.945293] lustre_kcompr_14914: compr zstd(15) in 512kB chunks took 802653 us (4 MB/s), compress ratio: 215.03 [ 409.782865] lustre_kcompr_14914: compr zstd(15) in 1024kB chunks took 828691 us (4 MB/s), compress ratio: 217.50 [ 411.024860] lustre_kcompr_14914: compr zstd(15) in 2048kB chunks took 1221807 us (3 MB/s), compress ratio: 219.71 [ 413.214654] lustre_kcompr_14914: compr zstd(15) in 4096kB chunks took 2181153 us (1 MB/s), compress ratio: 219.09 [ 413.245246] lustre_kcompr_14914: decompr zstd(15) took 3906 us (4 MB/s) [ 413.251517] lustre_kcompr_14914: test_comp_compress_decompress(zstd,15) ret 0 [ 413.283098] lustre_kcompr_14914: acompr zstd(15) of 128kB chunks took 26421 us (4 MB/s), compress ratio: 177.12 [ 413.289434] lustre_kcompr_14914: adecompr zstd(15) took 103 us (6 MB/s) [ 413.297889] lustre_kcompr_14914: test_acomp_compress_decompress(zstd,15) ret 0 [ 413.327223] lustre_kcompr_14914: compr zstdfast(1) in 64kB chunks took 7627 us (524 MB/s), compress ratio: 157.60 [ 413.335267] lustre_kcompr_14914: compr zstdfast(1) in 128kB chunks took 3081 us (1298 MB/s), compress ratio: 188.76 [ 413.348590] lustre_kcompr_14914: compr zstdfast(1) in 256kB chunks took 4721 us (847 MB/s), compress ratio: 200.43 [ 413.362956] lustre_kcompr_14914: compr zstdfast(1) in 512kB chunks took 2869 us (1394 MB/s), compress ratio: 208.32 [ 413.373054] lustre_kcompr_14914: compr zstdfast(1) in 1024kB chunks took 3206 us (1247 MB/s), compress ratio: 209.69 [ 413.384258] lustre_kcompr_14914: compr zstdfast(1) in 2048kB chunks took 3983 us (1004 MB/s), compress ratio: 210.74 [ 413.396292] lustre_kcompr_14914: compr zstdfast(1) in 4096kB chunks took 4920 us (813 MB/s), compress ratio: 211.80 [ 413.425033] lustre_kcompr_14914: decompr zstdfast(1) took 5639 us (3 MB/s) [ 413.444463] lustre_kcompr_14914: test_comp_compress_decompress(zstdfast,1) ret 0 [ 413.462982] lustre_kcompr_14914: acompr zstdfast(1) of 128kB chunks took 216 us (578 MB/s), compress ratio: 178.08 [ 413.470647] lustre_kcompr_14914: adecompr zstdfast(1) took 159 us (4 MB/s) [ 413.498124] lustre_kcompr_14914: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 413.563052] lustre_kcompr_14914: compr zstdfast(5) in 64kB chunks took 2606 us (1534 MB/s), compress ratio: 138.21 [ 413.604537] lustre_kcompr_14914: compr zstdfast(5) in 128kB chunks took 9657 us (414 MB/s), compress ratio: 164.02 [ 413.650851] lustre_kcompr_14914: compr zstdfast(5) in 256kB chunks took 11452 us (349 MB/s), compress ratio: 172.66 [ 413.680388] lustre_kcompr_14914: compr zstdfast(5) in 512kB chunks took 1875 us (2133 MB/s), compress ratio: 178.84 [ 413.723572] lustre_kcompr_14914: compr zstdfast(5) in 1024kB chunks took 9343 us (428 MB/s), compress ratio: 181.68 [ 413.771710] lustre_kcompr_14914: compr zstdfast(5) in 2048kB chunks took 9564 us (418 MB/s), compress ratio: 182.13 [ 413.808223] lustre_kcompr_14914: compr zstdfast(5) in 4096kB chunks took 6375 us (627 MB/s), compress ratio: 182.55 [ 413.861288] lustre_kcompr_14914: decompr zstdfast(5) took 2807 us (7 MB/s) [ 413.889695] lustre_kcompr_14914: test_comp_compress_decompress(zstdfast,5) ret 0 [ 413.900087] lustre_kcompr_14914: acompr zstdfast(5) of 128kB chunks took 515 us (242 MB/s), compress ratio: 156.59 [ 413.915863] lustre_kcompr_14914: adecompr zstdfast(5) took 96 us (8 MB/s) [ 413.954223] lustre_kcompr_14914: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 414.010678] lustre_kcompr_14914: compr zstdfast(12) in 64kB chunks took 22997 us (173 MB/s), compress ratio: 37.90 [ 414.030883] lustre_kcompr_14914: compr zstdfast(12) in 128kB chunks took 13915 us (287 MB/s), compress ratio: 42.95 [ 414.058247] lustre_kcompr_14914: compr zstdfast(12) in 256kB chunks took 8971 us (445 MB/s), compress ratio: 45.88 [ 414.086481] lustre_kcompr_14914: compr zstdfast(12) in 512kB chunks took 1800 us (2222 MB/s), compress ratio: 50.54 [ 414.132192] lustre_kcompr_14914: compr zstdfast(12) in 1024kB chunks took 1769 us (2261 MB/s), compress ratio: 54.66 [ 414.162122] lustre_kcompr_14914: compr zstdfast(12) in 2048kB chunks took 2495 us (1603 MB/s), compress ratio: 63.17 [ 414.187394] lustre_kcompr_14914: compr zstdfast(12) in 4096kB chunks took 9809 us (407 MB/s), compress ratio: 69.18 [ 414.210906] lustre_kcompr_14914: decompr zstdfast(12) took 3913 us (14 MB/s) [ 414.224983] lustre_kcompr_14914: test_comp_compress_decompress(zstdfast,12) ret 0 [ 414.246352] lustre_kcompr_14914: acompr zstdfast(12) of 128kB chunks took 136 us (919 MB/s), compress ratio: 40.87 [ 414.267674] lustre_kcompr_14914: adecompr zstdfast(12) took 119 us (25 MB/s) [ 414.323642] lustre_kcompr_14914: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 414.371113] lustre_kcompr_14914: compr zstdfast(15) in 64kB chunks took 10621 us (376 MB/s), compress ratio: 19.01 [ 414.401954] lustre_kcompr_14914: compr zstdfast(15) in 128kB chunks took 11555 us (346 MB/s), compress ratio: 19.83 [ 414.415822] lustre_kcompr_14914: compr zstdfast(15) in 256kB chunks took 3353 us (1192 MB/s), compress ratio: 20.57 [ 414.442335] lustre_kcompr_14914: compr zstdfast(15) in 512kB chunks took 12501 us (319 MB/s), compress ratio: 21.84 [ 414.456602] lustre_kcompr_14914: compr zstdfast(15) in 1024kB chunks took 2418 us (1654 MB/s), compress ratio: 25.05 [ 414.477675] lustre_kcompr_14914: compr zstdfast(15) in 2048kB chunks took 5155 us (775 MB/s), compress ratio: 29.51 [ 414.500903] lustre_kcompr_14914: compr zstdfast(15) in 4096kB chunks took 8300 us (481 MB/s), compress ratio: 36.01 [ 414.530711] lustre_kcompr_14914: decompr zstdfast(15) took 7274 us (15 MB/s) [ 414.540707] lustre_kcompr_14914: test_comp_compress_decompress(zstdfast,15) ret 0 [ 414.547648] lustre_kcompr_14914: acompr zstdfast(15) of 128kB chunks took 138 us (905 MB/s), compress ratio: 17.54 [ 414.555761] lustre_kcompr_14914: adecompr zstdfast(15) took 176 us (40 MB/s) [ 414.564046] lustre_kcompr_14914: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 414.575498] lustre_kcompr_14914: SUCCESS [ 422.611130] lustre_kcompr_31340: ***** [ 422.615136] lustre_kcompr_31340: (de)compression test on provided file /tmp/f84.sanity [ 422.626710] lustre_kcompr_31340: ***** [ 422.666773] lustre_kcompr_31340: compr lz4(1) in 64kB chunks took 19855 us (201 MB/s), compress ratio: 2.93 [ 422.698648] lustre_kcompr_31340: compr lz4(1) in 128kB chunks took 26656 us (150 MB/s), compress ratio: 3.04 [ 422.729120] lustre_kcompr_31340: compr lz4(1) in 256kB chunks took 25324 us (157 MB/s), compress ratio: 3.08 [ 422.757519] lustre_kcompr_31340: compr lz4(1) in 512kB chunks took 22912 us (174 MB/s), compress ratio: 3.10 [ 422.795642] lustre_kcompr_31340: compr lz4(1) in 1024kB chunks took 31581 us (126 MB/s), compress ratio: 3.11 [ 422.837939] lustre_kcompr_31340: compr lz4(1) in 2048kB chunks took 35179 us (113 MB/s), compress ratio: 3.11 [ 422.879780] lustre_kcompr_31340: compr lz4(1) in 4096kB chunks took 34033 us (117 MB/s), compress ratio: 3.12 [ 422.903829] lustre_kcompr_31340: decompr lz4(1) took 11004 us (116 MB/s) [ 422.908722] lustre_kcompr_31340: test_comp_compress_decompress(lz4,1) ret 0 [ 422.922794] lustre_kcompr_31340: acompr lz4(1) of 128kB chunks took 1716 us (72 MB/s), compress ratio: 2.68 [ 422.935139] lustre_kcompr_31340: adecompr lz4(1) took 400 us (116 MB/s) [ 422.950211] lustre_kcompr_31340: test_acomp_compress_decompress(lz4,1) ret 0 [ 423.001515] lustre_kcompr_31340: compr lz4(4) in 64kB chunks took 29303 us (136 MB/s), compress ratio: 2.67 [ 423.036852] lustre_kcompr_31340: compr lz4(4) in 128kB chunks took 25208 us (158 MB/s), compress ratio: 2.63 [ 423.079871] lustre_kcompr_31340: compr lz4(4) in 256kB chunks took 34032 us (117 MB/s), compress ratio: 2.68 [ 423.113825] lustre_kcompr_31340: compr lz4(4) in 512kB chunks took 26017 us (153 MB/s), compress ratio: 2.71 [ 423.149819] lustre_kcompr_31340: compr lz4(4) in 1024kB chunks took 28510 us (140 MB/s), compress ratio: 2.72 [ 423.189860] lustre_kcompr_31340: compr lz4(4) in 2048kB chunks took 29619 us (135 MB/s), compress ratio: 2.72 [ 423.224953] lustre_kcompr_31340: compr lz4(4) in 4096kB chunks took 28130 us (142 MB/s), compress ratio: 2.73 [ 423.254669] lustre_kcompr_31340: decompr lz4(4) took 11972 us (122 MB/s) [ 423.259759] lustre_kcompr_31340: test_comp_compress_decompress(lz4,4) ret 0 [ 423.267183] lustre_kcompr_31340: acompr lz4(4) of 128kB chunks took 1040 us (120 MB/s), compress ratio: 2.30 [ 423.273871] lustre_kcompr_31340: adecompr lz4(4) took 211 us (256 MB/s) [ 423.283717] lustre_kcompr_31340: test_acomp_compress_decompress(lz4,4) ret 0 [ 423.318635] lustre_kcompr_31340: compr lz4(9) in 64kB chunks took 21023 us (190 MB/s), compress ratio: 2.30 [ 423.363709] lustre_kcompr_31340: compr lz4(9) in 128kB chunks took 35875 us (111 MB/s), compress ratio: 2.15 [ 423.404716] lustre_kcompr_31340: compr lz4(9) in 256kB chunks took 30281 us (132 MB/s), compress ratio: 2.20 [ 423.437695] lustre_kcompr_31340: compr lz4(9) in 512kB chunks took 26911 us (148 MB/s), compress ratio: 2.23 [ 423.471811] lustre_kcompr_31340: compr lz4(9) in 1024kB chunks took 28779 us (138 MB/s), compress ratio: 2.25 [ 423.526898] lustre_kcompr_31340: compr lz4(9) in 2048kB chunks took 37216 us (107 MB/s), compress ratio: 2.25 [ 423.586754] lustre_kcompr_31340: compr lz4(9) in 4096kB chunks took 46357 us (86 MB/s), compress ratio: 2.26 [ 423.625536] lustre_kcompr_31340: decompr lz4(9) took 11932 us (148 MB/s) [ 423.632890] lustre_kcompr_31340: test_comp_compress_decompress(lz4,9) ret 0 [ 423.646680] lustre_kcompr_31340: acompr lz4(9) of 128kB chunks took 3493 us (35 MB/s), compress ratio: 1.87 [ 423.661171] lustre_kcompr_31340: adecompr lz4(9) took 842 us (79 MB/s) [ 423.675758] lustre_kcompr_31340: test_acomp_compress_decompress(lz4,9) ret 0 [ 423.748474] lustre_kcompr_31340: compr lz4(15) in 64kB chunks took 25776 us (155 MB/s), compress ratio: 1.63 [ 423.779549] lustre_kcompr_31340: compr lz4(15) in 128kB chunks took 17786 us (224 MB/s), compress ratio: 1.52 [ 423.801915] lustre_kcompr_31340: compr lz4(15) in 256kB chunks took 17987 us (222 MB/s), compress ratio: 1.56 [ 423.828678] lustre_kcompr_31340: compr lz4(15) in 512kB chunks took 20795 us (192 MB/s), compress ratio: 1.58 [ 423.851088] lustre_kcompr_31340: compr lz4(15) in 1024kB chunks took 14788 us (270 MB/s), compress ratio: 1.60 [ 423.876408] lustre_kcompr_31340: compr lz4(15) in 2048kB chunks took 19949 us (200 MB/s), compress ratio: 1.60 [ 423.900254] lustre_kcompr_31340: compr lz4(15) in 4096kB chunks took 17997 us (222 MB/s), compress ratio: 1.60 [ 423.917948] lustre_kcompr_31340: decompr lz4(15) took 5521 us (450 MB/s) [ 423.924847] lustre_kcompr_31340: test_comp_compress_decompress(lz4,15) ret 0 [ 423.929805] lustre_kcompr_31340: acompr lz4(15) of 128kB chunks took 680 us (183 MB/s), compress ratio: 1.33 [ 423.936807] lustre_kcompr_31340: adecompr lz4(15) took 489 us (192 MB/s) [ 423.944543] lustre_kcompr_31340: test_acomp_compress_decompress(lz4,15) ret 0 [ 424.121397] lustre_kcompr_31340: compr lz4hc(1) in 64kB chunks took 163443 us (24 MB/s), compress ratio: 3.58 [ 424.339291] lustre_kcompr_31340: compr lz4hc(1) in 128kB chunks took 212336 us (18 MB/s), compress ratio: 3.77 [ 424.533250] lustre_kcompr_31340: compr lz4hc(1) in 256kB chunks took 186345 us (21 MB/s), compress ratio: 3.88 [ 424.697977] lustre_kcompr_31340: compr lz4hc(1) in 512kB chunks took 155451 us (25 MB/s), compress ratio: 3.93 [ 424.948964] lustre_kcompr_31340: compr lz4hc(1) in 1024kB chunks took 244139 us (16 MB/s), compress ratio: 3.96 [ 425.113447] lustre_kcompr_31340: compr lz4hc(1) in 2048kB chunks took 153520 us (26 MB/s), compress ratio: 3.97 [ 425.397723] lustre_kcompr_31340: compr lz4hc(1) in 4096kB chunks took 269076 us (14 MB/s), compress ratio: 3.98 [ 425.430879] lustre_kcompr_31340: decompr lz4hc(1) took 8087 us (124 MB/s) [ 425.437055] lustre_kcompr_31340: test_comp_compress_decompress(lz4hc,1) ret 0 [ 425.461615] lustre_kcompr_31340: acompr lz4hc(1) of 128kB chunks took 11725 us (10 MB/s), compress ratio: 3.27 [ 425.475619] lustre_kcompr_31340: adecompr lz4hc(1) took 210 us (181 MB/s) [ 425.501625] lustre_kcompr_31340: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 425.815581] lustre_kcompr_31340: compr lz4hc(3) in 64kB chunks took 283253 us (14 MB/s), compress ratio: 3.68 [ 426.090724] lustre_kcompr_31340: compr lz4hc(3) in 128kB chunks took 264955 us (15 MB/s), compress ratio: 3.91 [ 426.399265] lustre_kcompr_31340: compr lz4hc(3) in 256kB chunks took 301534 us (13 MB/s), compress ratio: 4.04 [ 426.722487] lustre_kcompr_31340: compr lz4hc(3) in 512kB chunks took 316988 us (12 MB/s), compress ratio: 4.10 [ 427.151719] lustre_kcompr_31340: compr lz4hc(3) in 1024kB chunks took 419652 us (9 MB/s), compress ratio: 4.13 [ 427.458273] lustre_kcompr_31340: compr lz4hc(3) in 2048kB chunks took 301886 us (13 MB/s), compress ratio: 4.15 [ 427.904900] lustre_kcompr_31340: compr lz4hc(3) in 4096kB chunks took 436123 us (9 MB/s), compress ratio: 4.16 [ 427.941426] lustre_kcompr_31340: decompr lz4hc(3) took 18112 us (53 MB/s) [ 427.953729] lustre_kcompr_31340: test_comp_compress_decompress(lz4hc,3) ret 0 [ 427.974161] lustre_kcompr_31340: acompr lz4hc(3) of 128kB chunks took 9891 us (12 MB/s), compress ratio: 3.38 [ 427.984325] lustre_kcompr_31340: adecompr lz4hc(3) took 711 us (51 MB/s) [ 428.010736] lustre_kcompr_31340: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 428.595589] lustre_kcompr_31340: compr lz4hc(8) in 64kB chunks took 557152 us (7 MB/s), compress ratio: 3.72 [ 429.289946] lustre_kcompr_31340: compr lz4hc(8) in 128kB chunks took 683388 us (5 MB/s), compress ratio: 3.96 [ 429.891433] lustre_kcompr_31340: compr lz4hc(8) in 256kB chunks took 594539 us (6 MB/s), compress ratio: 4.10 [ 430.732409] lustre_kcompr_31340: compr lz4hc(8) in 512kB chunks took 831345 us (4 MB/s), compress ratio: 4.17 [ 431.514743] lustre_kcompr_31340: compr lz4hc(8) in 1024kB chunks took 773958 us (5 MB/s), compress ratio: 4.21 [ 432.789965] lustre_kcompr_31340: compr lz4hc(8) in 2048kB chunks took 1268099 us (3 MB/s), compress ratio: 4.22 [ 433.469802] lustre_kcompr_31340: compr lz4hc(8) in 4096kB chunks took 662584 us (6 MB/s), compress ratio: 4.23 [ 433.496704] lustre_kcompr_31340: decompr lz4hc(8) took 11184 us (84 MB/s) [ 433.504528] lustre_kcompr_31340: test_comp_compress_decompress(lz4hc,8) ret 0 [ 433.534636] lustre_kcompr_31340: acompr lz4hc(8) of 128kB chunks took 18953 us (6 MB/s), compress ratio: 3.42 [ 433.545700] lustre_kcompr_31340: adecompr lz4hc(8) took 169 us (215 MB/s) [ 433.584498] lustre_kcompr_31340: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 434.015374] lustre_kcompr_31340: compr lz4hc(15) in 64kB chunks took 410439 us (9 MB/s), compress ratio: 3.72 [ 434.741698] lustre_kcompr_31340: compr lz4hc(15) in 128kB chunks took 702689 us (5 MB/s), compress ratio: 3.96 [ 435.360851] lustre_kcompr_31340: compr lz4hc(15) in 256kB chunks took 613030 us (6 MB/s), compress ratio: 4.10 [ 435.998652] lustre_kcompr_31340: compr lz4hc(15) in 512kB chunks took 626946 us (6 MB/s), compress ratio: 4.17 [ 436.783292] lustre_kcompr_31340: compr lz4hc(15) in 1024kB chunks took 776718 us (5 MB/s), compress ratio: 4.21 [ 437.441432] lustre_kcompr_31340: compr lz4hc(15) in 2048kB chunks took 652906 us (6 MB/s), compress ratio: 4.22 [ 438.185309] lustre_kcompr_31340: compr lz4hc(15) in 4096kB chunks took 737953 us (5 MB/s), compress ratio: 4.23 [ 438.235926] lustre_kcompr_31340: decompr lz4hc(15) took 21782 us (43 MB/s) [ 438.241813] lustre_kcompr_31340: test_comp_compress_decompress(lz4hc,15) ret 0 [ 438.264618] lustre_kcompr_31340: acompr lz4hc(15) of 128kB chunks took 15808 us (7 MB/s), compress ratio: 3.42 [ 438.272851] lustre_kcompr_31340: adecompr lz4hc(15) took 1595 us (22 MB/s) [ 438.291141] lustre_kcompr_31340: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 438.338509] lustre_kcompr_31340: compr lzo(-1) in 64kB chunks took 34625 us (115 MB/s), compress ratio: 2.90 [ 438.372626] lustre_kcompr_31340: compr lzo(-1) in 128kB chunks took 26072 us (153 MB/s), compress ratio: 2.95 [ 438.410653] lustre_kcompr_31340: compr lzo(-1) in 256kB chunks took 30535 us (130 MB/s), compress ratio: 2.96 [ 438.460977] lustre_kcompr_31340: compr lzo(-1) in 512kB chunks took 42223 us (94 MB/s), compress ratio: 2.98 [ 438.536333] lustre_kcompr_31340: compr lzo(-1) in 1024kB chunks took 58887 us (67 MB/s), compress ratio: 2.97 [ 438.585673] lustre_kcompr_31340: compr lzo(-1) in 2048kB chunks took 42188 us (94 MB/s), compress ratio: 2.97 [ 438.608778] lustre_kcompr_31340: compr lzo(-1) in 4096kB chunks took 19409 us (206 MB/s), compress ratio: 2.96 [ 438.624832] lustre_kcompr_31340: decompr lzo(-1) took 6946 us (194 MB/s) [ 438.628918] lustre_kcompr_31340: test_comp_compress_decompress(lzo,-1) ret 0 [ 438.633084] lustre_kcompr_31340: acompr lzo(-1) of 128kB chunks took 664 us (188 MB/s), compress ratio: 2.62 [ 438.637633] lustre_kcompr_31340: adecompr lzo(-1) took 268 us (177 MB/s) [ 438.641909] lustre_kcompr_31340: test_acomp_compress_decompress(lzo,-1) ret 0 [ 439.532706] lustre_kcompr_31340: compr deflate(1) in 64kB chunks took 868182 us (4 MB/s), compress ratio: 3.51 [ 440.322574] lustre_kcompr_31340: compr deflate(1) in 128kB chunks took 769473 us (5 MB/s), compress ratio: 3.53 [ 440.932486] lustre_kcompr_31340: compr deflate(1) in 256kB chunks took 605652 us (6 MB/s), compress ratio: 3.53 [ 442.217871] lustre_kcompr_31340: compr deflate(1) in 512kB chunks took 1271607 us (3 MB/s), compress ratio: 3.54 [ 443.223195] lustre_kcompr_31340: compr deflate(1) in 1024kB chunks took 1000605 us (3 MB/s), compress ratio: 3.54 [ 443.817267] lustre_kcompr_31340: compr deflate(1) in 2048kB chunks took 585471 us (6 MB/s), compress ratio: 3.54 [ 444.481520] lustre_kcompr_31340: compr deflate(1) in 4096kB chunks took 653370 us (6 MB/s), compress ratio: 3.54 [ 444.582434] lustre_kcompr_31340: decompr deflate(1) took 79793 us (14 MB/s) [ 444.616685] lustre_kcompr_31340: test_comp_compress_decompress(deflate,1) ret 0 [ 444.651064] lustre_kcompr_31340: acompr deflate(1) of 128kB chunks took 18150 us (6 MB/s), compress ratio: 3.09 [ 444.662962] lustre_kcompr_31340: adecompr deflate(1) took 1136 us (35 MB/s) [ 444.677355] lustre_kcompr_31340: test_acomp_compress_decompress(deflate,1) ret 0 [ 445.426075] lustre_kcompr_31340: compr deflate(6) in 64kB chunks took 709155 us (5 MB/s), compress ratio: 3.51 [ 446.061558] lustre_kcompr_31340: compr deflate(6) in 128kB chunks took 619022 us (6 MB/s), compress ratio: 3.53 [ 447.064471] lustre_kcompr_31340: compr deflate(6) in 256kB chunks took 973887 us (4 MB/s), compress ratio: 3.53 [ 448.338655] lustre_kcompr_31340: compr deflate(6) in 512kB chunks took 1256569 us (3 MB/s), compress ratio: 3.54 [ 449.733521] lustre_kcompr_31340: compr deflate(6) in 1024kB chunks took 1381720 us (2 MB/s), compress ratio: 3.54 [ 450.902292] lustre_kcompr_31340: compr deflate(6) in 2048kB chunks took 1149951 us (3 MB/s), compress ratio: 3.54 [ 451.505281] lustre_kcompr_31340: compr deflate(6) in 4096kB chunks took 572719 us (6 MB/s), compress ratio: 3.54 [ 451.549834] lustre_kcompr_31340: decompr deflate(6) took 34392 us (32 MB/s) [ 451.555633] lustre_kcompr_31340: test_comp_compress_decompress(deflate,6) ret 0 [ 451.574784] lustre_kcompr_31340: acompr deflate(6) of 128kB chunks took 13972 us (8 MB/s), compress ratio: 3.09 [ 451.596431] lustre_kcompr_31340: adecompr deflate(6) took 1074 us (37 MB/s) [ 451.611757] lustre_kcompr_31340: test_acomp_compress_decompress(deflate,6) ret 0 [ 452.395102] lustre_kcompr_31340: compr deflate(9) in 64kB chunks took 744326 us (5 MB/s), compress ratio: 3.51 [ 452.927183] lustre_kcompr_31340: compr deflate(9) in 128kB chunks took 519064 us (7 MB/s), compress ratio: 3.53 [ 454.336885] lustre_kcompr_31340: compr deflate(9) in 256kB chunks took 1401189 us (2 MB/s), compress ratio: 3.53 [ 455.583489] lustre_kcompr_31340: compr deflate(9) in 512kB chunks took 1225159 us (3 MB/s), compress ratio: 3.54 [ 456.859951] lustre_kcompr_31340: compr deflate(9) in 1024kB chunks took 1261391 us (3 MB/s), compress ratio: 3.54 [ 457.865957] lustre_kcompr_31340: compr deflate(9) in 2048kB chunks took 999674 us (4 MB/s), compress ratio: 3.54 [ 458.537516] lustre_kcompr_31340: compr deflate(9) in 4096kB chunks took 663803 us (6 MB/s), compress ratio: 3.54 [ 458.632951] lustre_kcompr_31340: decompr deflate(9) took 71500 us (15 MB/s) [ 458.653221] lustre_kcompr_31340: test_comp_compress_decompress(deflate,9) ret 0 [ 458.692656] lustre_kcompr_31340: acompr deflate(9) of 128kB chunks took 25819 us (4 MB/s), compress ratio: 3.09 [ 458.704837] lustre_kcompr_31340: adecompr deflate(9) took 1330 us (30 MB/s) [ 458.739337] lustre_kcompr_31340: test_acomp_compress_decompress(deflate,9) ret 0 [ 458.954078] lustre_kcompr_31340: compr zstd(0) in 64kB chunks took 178397 us (22 MB/s), compress ratio: 4.28 [ 459.133576] lustre_kcompr_31340: compr zstd(0) in 128kB chunks took 159623 us (25 MB/s), compress ratio: 4.46 [ 459.282635] lustre_kcompr_31340: compr zstd(0) in 256kB chunks took 134295 us (29 MB/s), compress ratio: 4.61 [ 459.459071] lustre_kcompr_31340: compr zstd(0) in 512kB chunks took 167476 us (23 MB/s), compress ratio: 4.72 [ 459.698463] lustre_kcompr_31340: compr zstd(0) in 1024kB chunks took 228067 us (17 MB/s), compress ratio: 4.80 [ 460.005977] lustre_kcompr_31340: compr zstd(0) in 2048kB chunks took 291447 us (13 MB/s), compress ratio: 4.85 [ 460.169161] lustre_kcompr_31340: compr zstd(0) in 4096kB chunks took 149928 us (26 MB/s), compress ratio: 4.88 [ 460.207902] lustre_kcompr_31340: decompr zstd(0) took 28251 us (28 MB/s) [ 460.216609] lustre_kcompr_31340: test_comp_compress_decompress(zstd,0) ret 0 [ 460.224131] lustre_kcompr_31340: acompr zstd(0) of 128kB chunks took 2742 us (45 MB/s), compress ratio: 3.98 [ 460.229184] lustre_kcompr_31340: adecompr zstd(0) took 504 us (62 MB/s) [ 460.234542] lustre_kcompr_31340: test_acomp_compress_decompress(zstd,0) ret 0 [ 460.287617] lustre_kcompr_31340: compr zstd(1) in 64kB chunks took 42130 us (94 MB/s), compress ratio: 4.06 [ 460.338527] lustre_kcompr_31340: compr zstd(1) in 128kB chunks took 46770 us (85 MB/s), compress ratio: 4.20 [ 460.405800] lustre_kcompr_31340: compr zstd(1) in 256kB chunks took 61411 us (65 MB/s), compress ratio: 4.34 [ 460.483486] lustre_kcompr_31340: compr zstd(1) in 512kB chunks took 69059 us (57 MB/s), compress ratio: 4.34 [ 460.576549] lustre_kcompr_31340: compr zstd(1) in 1024kB chunks took 84820 us (47 MB/s), compress ratio: 4.37 [ 460.685664] lustre_kcompr_31340: compr zstd(1) in 2048kB chunks took 96944 us (41 MB/s), compress ratio: 4.39 [ 460.794144] lustre_kcompr_31340: compr zstd(1) in 4096kB chunks took 90258 us (44 MB/s), compress ratio: 4.40 [ 460.876786] lustre_kcompr_31340: decompr zstd(1) took 46897 us (19 MB/s) [ 460.883817] lustre_kcompr_31340: test_comp_compress_decompress(zstd,1) ret 0 [ 460.894277] lustre_kcompr_31340: acompr zstd(1) of 128kB chunks took 2650 us (47 MB/s), compress ratio: 3.73 [ 460.914801] lustre_kcompr_31340: adecompr zstd(1) took 3475 us (9 MB/s) [ 460.964763] lustre_kcompr_31340: test_acomp_compress_decompress(zstd,1) ret 0 [ 463.055557] lustre_kcompr_31340: compr zstd(10) in 64kB chunks took 2033213 us (1 MB/s), compress ratio: 4.80 [ 464.783811] lustre_kcompr_31340: compr zstd(10) in 128kB chunks took 1711137 us (2 MB/s), compress ratio: 5.09 [ 467.051967] lustre_kcompr_31340: compr zstd(10) in 256kB chunks took 2262722 us (1 MB/s), compress ratio: 5.34 [ 468.655951] lustre_kcompr_31340: compr zstd(10) in 512kB chunks took 1601302 us (2 MB/s), compress ratio: 5.45 [ 469.349247] lustre_kcompr_31340: compr zstd(10) in 1024kB chunks took 687972 us (5 MB/s), compress ratio: 5.62 [ 470.298651] lustre_kcompr_31340: compr zstd(10) in 2048kB chunks took 939094 us (4 MB/s), compress ratio: 5.76 [ 471.317333] lustre_kcompr_31340: compr zstd(10) in 4096kB chunks took 1014287 us (3 MB/s), compress ratio: 5.89 [ 471.406174] lustre_kcompr_31340: decompr zstd(10) took 74203 us (9 MB/s) [ 471.411985] lustre_kcompr_31340: test_comp_compress_decompress(zstd,10) ret 0 [ 471.523303] lustre_kcompr_31340: acompr zstd(10) of 128kB chunks took 106006 us (1 MB/s), compress ratio: 4.46 [ 471.548962] lustre_kcompr_31340: adecompr zstd(10) took 5375 us (5 MB/s) [ 471.560912] lustre_kcompr_31340: test_acomp_compress_decompress(zstd,10) ret 0 [ 490.677846] lustre_kcompr_31340: compr zstd(15) in 64kB chunks took 19068544 us (0 MB/s), compress ratio: 4.96 [ 507.057715] lustre_kcompr_31340: compr zstd(15) in 128kB chunks took 16358456 us (0 MB/s), compress ratio: 5.28 [ 522.339888] lustre_kcompr_31340: compr zstd(15) in 256kB chunks took 15264882 us (0 MB/s), compress ratio: 5.57 [ 531.912359] lustre_kcompr_31340: compr zstd(15) in 512kB chunks took 9567763 us (0 MB/s), compress ratio: 5.83 [ 547.216686] lustre_kcompr_31340: compr zstd(15) in 1024kB chunks took 15300155 us (0 MB/s), compress ratio: 6.06 [ 560.598112] lustre_kcompr_31340: compr zstd(15) in 2048kB chunks took 13371627 us (0 MB/s), compress ratio: 6.26 [ 576.038294] lustre_kcompr_31340: compr zstd(15) in 4096kB chunks took 15427830 us (0 MB/s), compress ratio: 6.46 [ 576.125921] lustre_kcompr_31340: decompr zstd(15) took 67862 us (9 MB/s) [ 576.134471] lustre_kcompr_31340: test_comp_compress_decompress(zstd,15) ret 0 [ 576.561138] lustre_kcompr_31340: acompr zstd(15) of 128kB chunks took 418144 us (0 MB/s), compress ratio: 4.64 [ 576.572546] lustre_kcompr_31340: adecompr zstd(15) took 903 us (29 MB/s) [ 576.606552] lustre_kcompr_31340: test_acomp_compress_decompress(zstd,15) ret 0 [ 576.782750] lustre_kcompr_31340: compr zstdfast(1) in 64kB chunks took 128869 us (31 MB/s), compress ratio: 3.49 [ 576.885650] lustre_kcompr_31340: compr zstdfast(1) in 128kB chunks took 90591 us (44 MB/s), compress ratio: 3.62 [ 576.963456] lustre_kcompr_31340: compr zstdfast(1) in 256kB chunks took 70787 us (56 MB/s), compress ratio: 3.84 [ 577.038189] lustre_kcompr_31340: compr zstdfast(1) in 512kB chunks took 68630 us (58 MB/s), compress ratio: 3.73 [ 577.118147] lustre_kcompr_31340: compr zstdfast(1) in 1024kB chunks took 70430 us (56 MB/s), compress ratio: 3.76 [ 577.211221] lustre_kcompr_31340: compr zstdfast(1) in 2048kB chunks took 86106 us (46 MB/s), compress ratio: 3.77 [ 577.315674] lustre_kcompr_31340: compr zstdfast(1) in 4096kB chunks took 86106 us (46 MB/s), compress ratio: 3.78 [ 577.368202] lustre_kcompr_31340: decompr zstdfast(1) took 32461 us (32 MB/s) [ 577.378105] lustre_kcompr_31340: test_comp_compress_decompress(zstdfast,1) ret 0 [ 577.388935] lustre_kcompr_31340: acompr zstdfast(1) of 128kB chunks took 3531 us (35 MB/s), compress ratio: 3.19 [ 577.402350] lustre_kcompr_31340: adecompr zstdfast(1) took 4736 us (8 MB/s) [ 577.410703] lustre_kcompr_31340: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 577.492552] lustre_kcompr_31340: compr zstdfast(5) in 64kB chunks took 61294 us (65 MB/s), compress ratio: 2.81 [ 577.559509] lustre_kcompr_31340: compr zstdfast(5) in 128kB chunks took 60005 us (66 MB/s), compress ratio: 2.93 [ 577.626509] lustre_kcompr_31340: compr zstdfast(5) in 256kB chunks took 56009 us (71 MB/s), compress ratio: 3.16 [ 577.702528] lustre_kcompr_31340: compr zstdfast(5) in 512kB chunks took 68064 us (58 MB/s), compress ratio: 3.04 [ 577.750568] lustre_kcompr_31340: compr zstdfast(5) in 1024kB chunks took 43521 us (91 MB/s), compress ratio: 3.07 [ 577.804049] lustre_kcompr_31340: compr zstdfast(5) in 2048kB chunks took 46522 us (85 MB/s), compress ratio: 3.08 [ 577.860927] lustre_kcompr_31340: compr zstdfast(5) in 4096kB chunks took 51309 us (77 MB/s), compress ratio: 3.09 [ 577.900548] lustre_kcompr_31340: decompr zstdfast(5) took 27437 us (47 MB/s) [ 577.906808] lustre_kcompr_31340: test_comp_compress_decompress(zstdfast,5) ret 0 [ 577.911653] lustre_kcompr_31340: acompr zstdfast(5) of 128kB chunks took 1001 us (124 MB/s), compress ratio: 2.56 [ 577.920150] lustre_kcompr_31340: adecompr zstdfast(5) took 1429 us (34 MB/s) [ 577.926826] lustre_kcompr_31340: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 577.974479] lustre_kcompr_31340: compr zstdfast(12) in 64kB chunks took 26480 us (151 MB/s), compress ratio: 1.43 [ 578.018703] lustre_kcompr_31340: compr zstdfast(12) in 128kB chunks took 32843 us (121 MB/s), compress ratio: 1.50 [ 578.053564] lustre_kcompr_31340: compr zstdfast(12) in 256kB chunks took 29283 us (136 MB/s), compress ratio: 1.62 [ 578.110949] lustre_kcompr_31340: compr zstdfast(12) in 512kB chunks took 47548 us (84 MB/s), compress ratio: 1.55 [ 578.146145] lustre_kcompr_31340: compr zstdfast(12) in 1024kB chunks took 28170 us (141 MB/s), compress ratio: 1.58 [ 578.194790] lustre_kcompr_31340: compr zstdfast(12) in 2048kB chunks took 42212 us (94 MB/s), compress ratio: 1.60 [ 578.239425] lustre_kcompr_31340: compr zstdfast(12) in 4096kB chunks took 38442 us (104 MB/s), compress ratio: 1.60 [ 578.280621] lustre_kcompr_31340: decompr zstdfast(12) took 15945 us (156 MB/s) [ 578.299025] lustre_kcompr_31340: test_comp_compress_decompress(zstdfast,12) ret 0 [ 578.305376] lustre_kcompr_31340: acompr zstdfast(12) of 128kB chunks took 749 us (166 MB/s), compress ratio: 1.37 [ 578.315631] lustre_kcompr_31340: adecompr zstdfast(12) took 323 us (282 MB/s) [ 578.338508] lustre_kcompr_31340: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 578.368604] lustre_kcompr_31340: compr zstdfast(15) in 64kB chunks took 11428 us (350 MB/s), compress ratio: 1.12 [ 578.383717] lustre_kcompr_31340: compr zstdfast(15) in 128kB chunks took 9865 us (405 MB/s), compress ratio: 1.16 [ 578.399439] lustre_kcompr_31340: compr zstdfast(15) in 256kB chunks took 11016 us (363 MB/s), compress ratio: 1.22 [ 578.414967] lustre_kcompr_31340: compr zstdfast(15) in 512kB chunks took 11192 us (357 MB/s), compress ratio: 1.20 [ 578.429236] lustre_kcompr_31340: compr zstdfast(15) in 1024kB chunks took 9686 us (412 MB/s), compress ratio: 1.22 [ 578.444633] lustre_kcompr_31340: compr zstdfast(15) in 2048kB chunks took 10144 us (394 MB/s), compress ratio: 1.23 [ 578.466459] lustre_kcompr_31340: compr zstdfast(15) in 4096kB chunks took 15358 us (260 MB/s), compress ratio: 1.23 [ 578.482679] lustre_kcompr_31340: decompr zstdfast(15) took 3319 us (975 MB/s) [ 578.486978] lustre_kcompr_31340: test_comp_compress_decompress(zstdfast,15) ret 0 [ 578.491255] lustre_kcompr_31340: acompr zstdfast(15) of 128kB chunks took 444 us (281 MB/s), compress ratio: 1.08 [ 578.495425] lustre_kcompr_31340: adecompr zstdfast(15) took 179 us (645 MB/s) [ 578.500430] lustre_kcompr_31340: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 578.502929] lustre_kcompr_31340: SUCCESS [ 584.263162] lustre_kcompr_24517: ***** [ 584.267116] lustre_kcompr_24517: (de)compression test on provided file /tmp/f84.sanity [ 584.271983] lustre_kcompr_24517: ***** [ 584.295192] lustre_kcompr_24517: compr lz4(1) in 64kB chunks took 14620 us (273 MB/s), compress ratio: 2.45 [ 584.315461] lustre_kcompr_24517: compr lz4(1) in 128kB chunks took 15503 us (258 MB/s), compress ratio: 2.39 [ 584.346662] lustre_kcompr_24517: compr lz4(1) in 256kB chunks took 24683 us (162 MB/s), compress ratio: 2.39 [ 584.367908] lustre_kcompr_24517: compr lz4(1) in 512kB chunks took 14431 us (277 MB/s), compress ratio: 2.39 [ 584.389186] lustre_kcompr_24517: compr lz4(1) in 1024kB chunks took 18009 us (222 MB/s), compress ratio: 2.39 [ 584.403559] lustre_kcompr_24517: compr lz4(1) in 2048kB chunks took 10855 us (368 MB/s), compress ratio: 2.39 [ 584.421596] lustre_kcompr_24517: compr lz4(1) in 4096kB chunks took 14517 us (275 MB/s), compress ratio: 2.39 [ 584.436311] lustre_kcompr_24517: decompr lz4(1) took 3050 us (547 MB/s) [ 584.443607] lustre_kcompr_24517: test_comp_compress_decompress(lz4,1) ret 0 [ 584.448556] lustre_kcompr_24517: acompr lz4(1) of 128kB chunks took 138 us (905 MB/s), compress ratio: 15.67 [ 584.454188] lustre_kcompr_24517: adecompr lz4(1) took 206 us (38 MB/s) [ 584.464269] lustre_kcompr_24517: test_acomp_compress_decompress(lz4,1) ret 0 [ 584.488545] lustre_kcompr_24517: compr lz4(4) in 64kB chunks took 12797 us (312 MB/s), compress ratio: 2.36 [ 584.503710] lustre_kcompr_24517: compr lz4(4) in 128kB chunks took 11090 us (360 MB/s), compress ratio: 2.35 [ 584.518991] lustre_kcompr_24517: compr lz4(4) in 256kB chunks took 12294 us (325 MB/s), compress ratio: 2.35 [ 584.540193] lustre_kcompr_24517: compr lz4(4) in 512kB chunks took 15819 us (252 MB/s), compress ratio: 2.35 [ 584.566640] lustre_kcompr_24517: compr lz4(4) in 1024kB chunks took 13490 us (296 MB/s), compress ratio: 2.35 [ 584.580239] lustre_kcompr_24517: compr lz4(4) in 2048kB chunks took 7613 us (525 MB/s), compress ratio: 2.35 [ 584.590350] lustre_kcompr_24517: compr lz4(4) in 4096kB chunks took 6542 us (611 MB/s), compress ratio: 2.35 [ 584.600037] lustre_kcompr_24517: decompr lz4(4) took 2312 us (735 MB/s) [ 584.602870] lustre_kcompr_24517: test_comp_compress_decompress(lz4,4) ret 0 [ 584.605986] lustre_kcompr_24517: acompr lz4(4) of 128kB chunks took 261 us (478 MB/s), compress ratio: 15.30 [ 584.610232] lustre_kcompr_24517: adecompr lz4(4) took 221 us (36 MB/s) [ 584.618135] lustre_kcompr_24517: test_acomp_compress_decompress(lz4,4) ret 0 [ 584.634202] lustre_kcompr_24517: compr lz4(9) in 64kB chunks took 7852 us (509 MB/s), compress ratio: 2.32 [ 584.656333] lustre_kcompr_24517: compr lz4(9) in 128kB chunks took 12817 us (312 MB/s), compress ratio: 2.31 [ 584.691400] lustre_kcompr_24517: compr lz4(9) in 256kB chunks took 19154 us (208 MB/s), compress ratio: 2.31 [ 584.726381] lustre_kcompr_24517: compr lz4(9) in 512kB chunks took 26819 us (149 MB/s), compress ratio: 2.31 [ 584.757523] lustre_kcompr_24517: compr lz4(9) in 1024kB chunks took 14790 us (270 MB/s), compress ratio: 2.31 [ 584.774847] lustre_kcompr_24517: compr lz4(9) in 2048kB chunks took 10219 us (391 MB/s), compress ratio: 2.32 [ 584.783937] lustre_kcompr_24517: compr lz4(9) in 4096kB chunks took 5057 us (790 MB/s), compress ratio: 2.32 [ 584.795102] lustre_kcompr_24517: decompr lz4(9) took 2494 us (691 MB/s) [ 584.800028] lustre_kcompr_24517: test_comp_compress_decompress(lz4,9) ret 0 [ 584.808173] lustre_kcompr_24517: acompr lz4(9) of 128kB chunks took 109 us (1146 MB/s), compress ratio: 14.81 [ 584.817344] lustre_kcompr_24517: adecompr lz4(9) took 166 us (50 MB/s) [ 584.823981] lustre_kcompr_24517: test_acomp_compress_decompress(lz4,9) ret 0 [ 584.859367] lustre_kcompr_24517: compr lz4(15) in 64kB chunks took 15018 us (266 MB/s), compress ratio: 2.23 [ 584.890812] lustre_kcompr_24517: compr lz4(15) in 128kB chunks took 21045 us (190 MB/s), compress ratio: 2.23 [ 584.923108] lustre_kcompr_24517: compr lz4(15) in 256kB chunks took 13341 us (299 MB/s), compress ratio: 2.23 [ 584.967451] lustre_kcompr_24517: compr lz4(15) in 512kB chunks took 20985 us (190 MB/s), compress ratio: 2.23 [ 585.003671] lustre_kcompr_24517: compr lz4(15) in 1024kB chunks took 18604 us (215 MB/s), compress ratio: 2.23 [ 585.037217] lustre_kcompr_24517: compr lz4(15) in 2048kB chunks took 24721 us (161 MB/s), compress ratio: 2.23 [ 585.064444] lustre_kcompr_24517: compr lz4(15) in 4096kB chunks took 15708 us (254 MB/s), compress ratio: 2.23 [ 585.098498] lustre_kcompr_24517: decompr lz4(15) took 6929 us (258 MB/s) [ 585.103159] lustre_kcompr_24517: test_comp_compress_decompress(lz4,15) ret 0 [ 585.121143] lustre_kcompr_24517: acompr lz4(15) of 128kB chunks took 99 us (1262 MB/s), compress ratio: 14.18 [ 585.127406] lustre_kcompr_24517: adecompr lz4(15) took 91 us (96 MB/s) [ 585.138341] lustre_kcompr_24517: test_acomp_compress_decompress(lz4,15) ret 0 [ 585.403637] lustre_kcompr_24517: compr lz4hc(1) in 64kB chunks took 254280 us (15 MB/s), compress ratio: 2.54 [ 585.531220] lustre_kcompr_24517: compr lz4hc(1) in 128kB chunks took 121760 us (32 MB/s), compress ratio: 2.61 [ 585.786910] lustre_kcompr_24517: compr lz4hc(1) in 256kB chunks took 251506 us (15 MB/s), compress ratio: 2.64 [ 586.011958] lustre_kcompr_24517: compr lz4hc(1) in 512kB chunks took 217813 us (18 MB/s), compress ratio: 2.66 [ 586.336858] lustre_kcompr_24517: compr lz4hc(1) in 1024kB chunks took 318335 us (12 MB/s), compress ratio: 2.67 [ 586.626432] lustre_kcompr_24517: compr lz4hc(1) in 2048kB chunks took 279456 us (14 MB/s), compress ratio: 2.67 [ 586.935745] lustre_kcompr_24517: compr lz4hc(1) in 4096kB chunks took 301795 us (13 MB/s), compress ratio: 2.67 [ 586.952529] lustre_kcompr_24517: decompr lz4hc(1) took 4680 us (319 MB/s) [ 586.959424] lustre_kcompr_24517: test_comp_compress_decompress(lz4hc,1) ret 0 [ 586.970881] lustre_kcompr_24517: acompr lz4hc(1) of 128kB chunks took 1123 us (111 MB/s), compress ratio: 15.97 [ 586.977192] lustre_kcompr_24517: adecompr lz4hc(1) took 106 us (73 MB/s) [ 586.982692] lustre_kcompr_24517: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 587.145228] lustre_kcompr_24517: compr lz4hc(3) in 64kB chunks took 152577 us (26 MB/s), compress ratio: 2.57 [ 587.417496] lustre_kcompr_24517: compr lz4hc(3) in 128kB chunks took 264714 us (15 MB/s), compress ratio: 2.64 [ 587.789824] lustre_kcompr_24517: compr lz4hc(3) in 256kB chunks took 362127 us (11 MB/s), compress ratio: 2.68 [ 588.010461] lustre_kcompr_24517: compr lz4hc(3) in 512kB chunks took 207376 us (19 MB/s), compress ratio: 2.69 [ 588.264044] lustre_kcompr_24517: compr lz4hc(3) in 1024kB chunks took 244793 us (16 MB/s), compress ratio: 2.70 [ 588.508952] lustre_kcompr_24517: compr lz4hc(3) in 2048kB chunks took 234331 us (17 MB/s), compress ratio: 2.71 [ 588.896400] lustre_kcompr_24517: compr lz4hc(3) in 4096kB chunks took 378518 us (10 MB/s), compress ratio: 2.71 [ 588.924271] lustre_kcompr_24517: decompr lz4hc(3) took 7707 us (190 MB/s) [ 588.935958] lustre_kcompr_24517: test_comp_compress_decompress(lz4hc,3) ret 0 [ 588.944755] lustre_kcompr_24517: acompr lz4hc(3) of 128kB chunks took 832 us (150 MB/s), compress ratio: 16.00 [ 588.951437] lustre_kcompr_24517: adecompr lz4hc(3) took 332 us (23 MB/s) [ 588.958682] lustre_kcompr_24517: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 589.666245] lustre_kcompr_24517: compr lz4hc(8) in 64kB chunks took 687769 us (5 MB/s), compress ratio: 2.60 [ 590.360782] lustre_kcompr_24517: compr lz4hc(8) in 128kB chunks took 680731 us (5 MB/s), compress ratio: 2.66 [ 591.144922] lustre_kcompr_24517: compr lz4hc(8) in 256kB chunks took 775066 us (5 MB/s), compress ratio: 2.70 [ 592.014403] lustre_kcompr_24517: compr lz4hc(8) in 512kB chunks took 859693 us (4 MB/s), compress ratio: 2.71 [ 592.988194] lustre_kcompr_24517: compr lz4hc(8) in 1024kB chunks took 966697 us (4 MB/s), compress ratio: 2.72 [ 594.007791] lustre_kcompr_24517: compr lz4hc(8) in 2048kB chunks took 1010235 us (3 MB/s), compress ratio: 2.73 [ 594.905778] lustre_kcompr_24517: compr lz4hc(8) in 4096kB chunks took 888961 us (4 MB/s), compress ratio: 2.73 [ 594.938171] lustre_kcompr_24517: decompr lz4hc(8) took 7152 us (204 MB/s) [ 594.946952] lustre_kcompr_24517: test_comp_compress_decompress(lz4hc,8) ret 0 [ 594.968526] lustre_kcompr_24517: acompr lz4hc(8) of 128kB chunks took 8607 us (14 MB/s), compress ratio: 16.17 [ 594.985829] lustre_kcompr_24517: adecompr lz4hc(8) took 111 us (69 MB/s) [ 595.032589] lustre_kcompr_24517: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 603.377154] lustre_kcompr_24517: compr lz4hc(15) in 64kB chunks took 8318247 us (0 MB/s), compress ratio: 2.61 [ 615.705719] lustre_kcompr_24517: compr lz4hc(15) in 128kB chunks took 12323863 us (0 MB/s), compress ratio: 2.67 [ 629.684164] lustre_kcompr_24517: compr lz4hc(15) in 256kB chunks took 13973837 us (0 MB/s), compress ratio: 2.71 [ 646.924263] lustre_kcompr_24517: compr lz4hc(15) in 512kB chunks took 17230160 us (0 MB/s), compress ratio: 2.72 [ 663.729303] lustre_kcompr_24517: compr lz4hc(15) in 1024kB chunks took 16793033 us (0 MB/s), compress ratio: 2.73 [ 680.229968] lustre_kcompr_24517: compr lz4hc(15) in 2048kB chunks took 16485894 us (0 MB/s), compress ratio: 2.74 [ 696.684989] lustre_kcompr_24517: compr lz4hc(15) in 4096kB chunks took 16428927 us (0 MB/s), compress ratio: 2.74 [ 696.722417] lustre_kcompr_24517: decompr lz4hc(15) took 11761 us (123 MB/s) [ 696.732437] lustre_kcompr_24517: test_comp_compress_decompress(lz4hc,15) ret 0 [ 696.797254] lustre_kcompr_24517: acompr lz4hc(15) of 128kB chunks took 55480 us (2 MB/s), compress ratio: 16.30 [ 696.807511] lustre_kcompr_24517: adecompr lz4hc(15) took 224 us (34 MB/s) [ 696.823705] lustre_kcompr_24517: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 696.847465] lustre_kcompr_24517: compr lzo(-1) in 64kB chunks took 17952 us (222 MB/s), compress ratio: 2.35 [ 696.873309] lustre_kcompr_24517: compr lzo(-1) in 128kB chunks took 18812 us (212 MB/s), compress ratio: 2.35 [ 696.892917] lustre_kcompr_24517: compr lzo(-1) in 256kB chunks took 14063 us (284 MB/s), compress ratio: 2.35 [ 696.934802] lustre_kcompr_24517: compr lzo(-1) in 512kB chunks took 36138 us (110 MB/s), compress ratio: 2.36 [ 696.969278] lustre_kcompr_24517: compr lzo(-1) in 1024kB chunks took 27950 us (143 MB/s), compress ratio: 2.36 [ 697.016272] lustre_kcompr_24517: compr lzo(-1) in 2048kB chunks took 37291 us (107 MB/s), compress ratio: 2.36 [ 697.048517] lustre_kcompr_24517: compr lzo(-1) in 4096kB chunks took 19888 us (201 MB/s), compress ratio: 2.36 [ 697.082671] lustre_kcompr_24517: decompr lzo(-1) took 13325 us (127 MB/s) [ 697.092204] lustre_kcompr_24517: test_comp_compress_decompress(lzo,-1) ret 0 [ 697.109918] lustre_kcompr_24517: acompr lzo(-1) of 128kB chunks took 1342 us (93 MB/s), compress ratio: 15.45 [ 697.120242] lustre_kcompr_24517: adecompr lzo(-1) took 727 us (11 MB/s) [ 697.133510] lustre_kcompr_24517: test_acomp_compress_decompress(lzo,-1) ret 0 [ 697.867141] lustre_kcompr_24517: compr deflate(1) in 64kB chunks took 716409 us (5 MB/s), compress ratio: 3.27 [ 698.703984] lustre_kcompr_24517: compr deflate(1) in 128kB chunks took 826061 us (4 MB/s), compress ratio: 3.28 [ 699.520389] lustre_kcompr_24517: compr deflate(1) in 256kB chunks took 803901 us (4 MB/s), compress ratio: 3.28 [ 700.002853] lustre_kcompr_24517: compr deflate(1) in 512kB chunks took 477516 us (8 MB/s), compress ratio: 3.28 [ 700.720502] lustre_kcompr_24517: compr deflate(1) in 1024kB chunks took 705035 us (5 MB/s), compress ratio: 3.28 [ 701.511520] lustre_kcompr_24517: compr deflate(1) in 2048kB chunks took 777179 us (5 MB/s), compress ratio: 3.28 [ 702.300597] lustre_kcompr_24517: compr deflate(1) in 4096kB chunks took 778949 us (5 MB/s), compress ratio: 3.28 [ 702.390644] lustre_kcompr_24517: decompr deflate(1) took 71185 us (17 MB/s) [ 702.416098] lustre_kcompr_24517: test_comp_compress_decompress(deflate,1) ret 0 [ 702.450667] lustre_kcompr_24517: acompr deflate(1) of 128kB chunks took 24517 us (5 MB/s), compress ratio: 21.43 [ 702.456842] lustre_kcompr_24517: adecompr deflate(1) took 521 us (11 MB/s) [ 702.474991] lustre_kcompr_24517: test_acomp_compress_decompress(deflate,1) ret 0 [ 703.154109] lustre_kcompr_24517: compr deflate(6) in 64kB chunks took 665804 us (6 MB/s), compress ratio: 3.27 [ 704.095483] lustre_kcompr_24517: compr deflate(6) in 128kB chunks took 929927 us (4 MB/s), compress ratio: 3.28 [ 704.843713] lustre_kcompr_24517: compr deflate(6) in 256kB chunks took 725701 us (5 MB/s), compress ratio: 3.28 [ 705.729892] lustre_kcompr_24517: compr deflate(6) in 512kB chunks took 873648 us (4 MB/s), compress ratio: 3.28 [ 706.699411] lustre_kcompr_24517: compr deflate(6) in 1024kB chunks took 952207 us (4 MB/s), compress ratio: 3.28 [ 707.569776] lustre_kcompr_24517: compr deflate(6) in 2048kB chunks took 853927 us (4 MB/s), compress ratio: 3.28 [ 708.445427] lustre_kcompr_24517: compr deflate(6) in 4096kB chunks took 853241 us (4 MB/s), compress ratio: 3.28 [ 708.577076] lustre_kcompr_24517: decompr deflate(6) took 97694 us (12 MB/s) [ 708.594038] lustre_kcompr_24517: test_comp_compress_decompress(deflate,6) ret 0 [ 708.618369] lustre_kcompr_24517: acompr deflate(6) of 128kB chunks took 13580 us (9 MB/s), compress ratio: 21.43 [ 708.626823] lustre_kcompr_24517: adecompr deflate(6) took 278 us (20 MB/s) [ 708.643051] lustre_kcompr_24517: test_acomp_compress_decompress(deflate,6) ret 0 [ 709.488319] lustre_kcompr_24517: compr deflate(9) in 64kB chunks took 811350 us (4 MB/s), compress ratio: 3.27 [ 710.349695] lustre_kcompr_24517: compr deflate(9) in 128kB chunks took 851382 us (4 MB/s), compress ratio: 3.28 [ 711.081431] lustre_kcompr_24517: compr deflate(9) in 256kB chunks took 723780 us (5 MB/s), compress ratio: 3.28 [ 711.846567] lustre_kcompr_24517: compr deflate(9) in 512kB chunks took 755969 us (5 MB/s), compress ratio: 3.28 [ 712.646835] lustre_kcompr_24517: compr deflate(9) in 1024kB chunks took 793572 us (5 MB/s), compress ratio: 3.28 [ 713.423157] lustre_kcompr_24517: compr deflate(9) in 2048kB chunks took 772729 us (5 MB/s), compress ratio: 3.28 [ 714.314502] lustre_kcompr_24517: compr deflate(9) in 4096kB chunks took 868945 us (4 MB/s), compress ratio: 3.28 [ 714.423425] lustre_kcompr_24517: decompr deflate(9) took 72145 us (16 MB/s) [ 714.458137] lustre_kcompr_24517: test_comp_compress_decompress(deflate,9) ret 0 [ 714.477174] lustre_kcompr_24517: acompr deflate(9) of 128kB chunks took 9525 us (13 MB/s), compress ratio: 21.43 [ 714.489052] lustre_kcompr_24517: adecompr deflate(9) took 281 us (20 MB/s) [ 714.496646] lustre_kcompr_24517: test_acomp_compress_decompress(deflate,9) ret 0 [ 714.692239] lustre_kcompr_24517: compr zstd(0) in 64kB chunks took 170112 us (23 MB/s), compress ratio: 3.28 [ 714.884038] lustre_kcompr_24517: compr zstd(0) in 128kB chunks took 180111 us (22 MB/s), compress ratio: 3.26 [ 715.059447] lustre_kcompr_24517: compr zstd(0) in 256kB chunks took 166505 us (24 MB/s), compress ratio: 3.31 [ 715.293070] lustre_kcompr_24517: compr zstd(0) in 512kB chunks took 228101 us (17 MB/s), compress ratio: 3.32 [ 715.594376] lustre_kcompr_24517: compr zstd(0) in 1024kB chunks took 289700 us (13 MB/s), compress ratio: 3.32 [ 715.896124] lustre_kcompr_24517: compr zstd(0) in 2048kB chunks took 291066 us (13 MB/s), compress ratio: 3.33 [ 716.298283] lustre_kcompr_24517: compr zstd(0) in 4096kB chunks took 395585 us (10 MB/s), compress ratio: 3.33 [ 716.341742] lustre_kcompr_24517: decompr zstd(0) took 32120 us (37 MB/s) [ 716.349927] lustre_kcompr_24517: test_comp_compress_decompress(zstd,0) ret 0 [ 716.357203] lustre_kcompr_24517: acompr zstd(0) of 128kB chunks took 1052 us (118 MB/s), compress ratio: 22.64 [ 716.361685] lustre_kcompr_24517: adecompr zstd(0) took 249 us (22 MB/s) [ 716.381868] lustre_kcompr_24517: test_acomp_compress_decompress(zstd,0) ret 0 [ 716.462264] lustre_kcompr_24517: compr zstd(1) in 64kB chunks took 43548 us (91 MB/s), compress ratio: 3.22 [ 716.501154] lustre_kcompr_24517: compr zstd(1) in 128kB chunks took 33735 us (118 MB/s), compress ratio: 3.18 [ 716.572364] lustre_kcompr_24517: compr zstd(1) in 256kB chunks took 59585 us (67 MB/s), compress ratio: 3.19 [ 716.640148] lustre_kcompr_24517: compr zstd(1) in 512kB chunks took 61703 us (64 MB/s), compress ratio: 3.19 [ 716.706850] lustre_kcompr_24517: compr zstd(1) in 1024kB chunks took 61949 us (64 MB/s), compress ratio: 3.19 [ 716.788641] lustre_kcompr_24517: compr zstd(1) in 2048kB chunks took 76647 us (52 MB/s), compress ratio: 3.19 [ 716.884883] lustre_kcompr_24517: compr zstd(1) in 4096kB chunks took 81166 us (49 MB/s), compress ratio: 3.19 [ 716.951403] lustre_kcompr_24517: decompr zstd(1) took 33735 us (37 MB/s) [ 716.955988] lustre_kcompr_24517: test_comp_compress_decompress(zstd,1) ret 0 [ 716.961507] lustre_kcompr_24517: acompr zstd(1) of 128kB chunks took 254 us (492 MB/s), compress ratio: 22.79 [ 716.965636] lustre_kcompr_24517: adecompr zstd(1) took 170 us (32 MB/s) [ 716.979843] lustre_kcompr_24517: test_acomp_compress_decompress(zstd,1) ret 0 [ 717.904773] lustre_kcompr_24517: compr zstd(10) in 64kB chunks took 913751 us (4 MB/s), compress ratio: 3.33 [ 718.847149] lustre_kcompr_24517: compr zstd(10) in 128kB chunks took 932688 us (4 MB/s), compress ratio: 3.33 [ 720.101425] lustre_kcompr_24517: compr zstd(10) in 256kB chunks took 1241140 us (3 MB/s), compress ratio: 3.37 [ 721.026801] lustre_kcompr_24517: compr zstd(10) in 512kB chunks took 915833 us (4 MB/s), compress ratio: 3.40 [ 722.226968] lustre_kcompr_24517: compr zstd(10) in 1024kB chunks took 1194861 us (3 MB/s), compress ratio: 3.42 [ 723.424993] lustre_kcompr_24517: compr zstd(10) in 2048kB chunks took 1191476 us (3 MB/s), compress ratio: 3.46 [ 725.012934] lustre_kcompr_24517: compr zstd(10) in 4096kB chunks took 1578255 us (2 MB/s), compress ratio: 3.50 [ 725.097654] lustre_kcompr_24517: decompr zstd(10) took 60282 us (18 MB/s) [ 725.110171] lustre_kcompr_24517: test_comp_compress_decompress(zstd,10) ret 0 [ 725.120179] lustre_kcompr_24517: acompr zstd(10) of 128kB chunks took 5244 us (23 MB/s), compress ratio: 22.78 [ 725.129725] lustre_kcompr_24517: adecompr zstd(10) took 197 us (27 MB/s) [ 725.159376] lustre_kcompr_24517: test_acomp_compress_decompress(zstd,10) ret 0 [ 735.129645] lustre_kcompr_24517: compr zstd(15) in 64kB chunks took 9946834 us (0 MB/s), compress ratio: 3.36 [ 745.296845] lustre_kcompr_24517: compr zstd(15) in 128kB chunks took 10161822 us (0 MB/s), compress ratio: 3.39 [ 754.068699] lustre_kcompr_24517: compr zstd(15) in 256kB chunks took 8765805 us (0 MB/s), compress ratio: 3.40 [ 761.018435] lustre_kcompr_24517: compr zstd(15) in 512kB chunks took 6944315 us (0 MB/s), compress ratio: 3.42 [ 767.574868] lustre_kcompr_24517: compr zstd(15) in 1024kB chunks took 6551242 us (0 MB/s), compress ratio: 3.43 [ 774.377856] lustre_kcompr_24517: compr zstd(15) in 2048kB chunks took 6792734 us (0 MB/s), compress ratio: 3.48 [ 783.122340] lustre_kcompr_24517: compr zstd(15) in 4096kB chunks took 8720683 us (0 MB/s), compress ratio: 3.56 [ 783.215624] lustre_kcompr_24517: decompr zstd(15) took 65644 us (17 MB/s) [ 783.251725] lustre_kcompr_24517: test_comp_compress_decompress(zstd,15) ret 0 [ 783.424391] lustre_kcompr_24517: acompr zstd(15) of 128kB chunks took 154115 us (0 MB/s), compress ratio: 23.92 [ 783.434831] lustre_kcompr_24517: adecompr zstd(15) took 174 us (30 MB/s) [ 783.482670] lustre_kcompr_24517: test_acomp_compress_decompress(zstd,15) ret 0 [ 783.585946] lustre_kcompr_24517: compr zstdfast(1) in 64kB chunks took 61081 us (65 MB/s), compress ratio: 2.47 [ 783.640537] lustre_kcompr_24517: compr zstdfast(1) in 128kB chunks took 41150 us (97 MB/s), compress ratio: 2.48 [ 783.706500] lustre_kcompr_24517: compr zstdfast(1) in 256kB chunks took 58691 us (68 MB/s), compress ratio: 2.53 [ 783.799901] lustre_kcompr_24517: compr zstdfast(1) in 512kB chunks took 79655 us (50 MB/s), compress ratio: 2.42 [ 783.892482] lustre_kcompr_24517: compr zstdfast(1) in 1024kB chunks took 77902 us (51 MB/s), compress ratio: 2.42 [ 783.989404] lustre_kcompr_24517: compr zstdfast(1) in 2048kB chunks took 83669 us (47 MB/s), compress ratio: 2.42 [ 784.052130] lustre_kcompr_24517: compr zstdfast(1) in 4096kB chunks took 52693 us (75 MB/s), compress ratio: 2.42 [ 784.081380] lustre_kcompr_24517: decompr zstdfast(1) took 7796 us (211 MB/s) [ 784.092899] lustre_kcompr_24517: test_comp_compress_decompress(zstdfast,1) ret 0 [ 784.112273] lustre_kcompr_24517: acompr zstdfast(1) of 128kB chunks took 297 us (420 MB/s), compress ratio: 17.28 [ 784.132374] lustre_kcompr_24517: adecompr zstdfast(1) took 447 us (16 MB/s) [ 784.155398] lustre_kcompr_24517: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 784.219056] lustre_kcompr_24517: compr zstdfast(5) in 64kB chunks took 37842 us (105 MB/s), compress ratio: 2.38 [ 784.270272] lustre_kcompr_24517: compr zstdfast(5) in 128kB chunks took 43276 us (92 MB/s), compress ratio: 2.38 [ 784.314380] lustre_kcompr_24517: compr zstdfast(5) in 256kB chunks took 28834 us (138 MB/s), compress ratio: 2.40 [ 784.353627] lustre_kcompr_24517: compr zstdfast(5) in 512kB chunks took 26448 us (151 MB/s), compress ratio: 2.36 [ 784.419323] lustre_kcompr_24517: compr zstdfast(5) in 1024kB chunks took 49494 us (80 MB/s), compress ratio: 2.36 [ 784.491988] lustre_kcompr_24517: compr zstdfast(5) in 2048kB chunks took 50675 us (78 MB/s), compress ratio: 2.36 [ 784.547467] lustre_kcompr_24517: compr zstdfast(5) in 4096kB chunks took 42067 us (95 MB/s), compress ratio: 2.36 [ 784.585405] lustre_kcompr_24517: decompr zstdfast(5) took 16586 us (101 MB/s) [ 784.612991] lustre_kcompr_24517: test_comp_compress_decompress(zstdfast,5) ret 0 [ 784.628855] lustre_kcompr_24517: acompr zstdfast(5) of 128kB chunks took 2994 us (41 MB/s), compress ratio: 16.12 [ 784.643349] lustre_kcompr_24517: adecompr zstdfast(5) took 2316 us (3 MB/s) [ 784.659232] lustre_kcompr_24517: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 784.700502] lustre_kcompr_24517: compr zstdfast(12) in 64kB chunks took 12129 us (329 MB/s), compress ratio: 2.07 [ 784.727441] lustre_kcompr_24517: compr zstdfast(12) in 128kB chunks took 15175 us (263 MB/s), compress ratio: 2.07 [ 784.748620] lustre_kcompr_24517: compr zstdfast(12) in 256kB chunks took 12158 us (329 MB/s), compress ratio: 2.08 [ 784.773564] lustre_kcompr_24517: compr zstdfast(12) in 512kB chunks took 13400 us (298 MB/s), compress ratio: 2.07 [ 784.794814] lustre_kcompr_24517: compr zstdfast(12) in 1024kB chunks took 12728 us (314 MB/s), compress ratio: 2.07 [ 784.826922] lustre_kcompr_24517: compr zstdfast(12) in 2048kB chunks took 21429 us (186 MB/s), compress ratio: 2.07 [ 784.872430] lustre_kcompr_24517: compr zstdfast(12) in 4096kB chunks took 32622 us (122 MB/s), compress ratio: 2.08 [ 784.912178] lustre_kcompr_24517: decompr zstdfast(12) took 7905 us (243 MB/s) [ 784.942112] lustre_kcompr_24517: test_comp_compress_decompress(zstdfast,12) ret 0 [ 784.957871] lustre_kcompr_24517: acompr zstdfast(12) of 128kB chunks took 162 us (771 MB/s), compress ratio: 13.13 [ 784.975722] lustre_kcompr_24517: adecompr zstdfast(12) took 118 us (80 MB/s) [ 785.001730] lustre_kcompr_24517: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 785.048446] lustre_kcompr_24517: compr zstdfast(15) in 64kB chunks took 16804 us (238 MB/s), compress ratio: 1.82 [ 785.073966] lustre_kcompr_24517: compr zstdfast(15) in 128kB chunks took 8996 us (444 MB/s), compress ratio: 1.83 [ 785.104532] lustre_kcompr_24517: compr zstdfast(15) in 256kB chunks took 18195 us (219 MB/s), compress ratio: 1.83 [ 785.131311] lustre_kcompr_24517: compr zstdfast(15) in 512kB chunks took 11408 us (350 MB/s), compress ratio: 1.83 [ 785.163323] lustre_kcompr_24517: compr zstdfast(15) in 1024kB chunks took 15602 us (256 MB/s), compress ratio: 1.83 [ 785.188083] lustre_kcompr_24517: compr zstdfast(15) in 2048kB chunks took 14932 us (267 MB/s), compress ratio: 1.83 [ 785.217877] lustre_kcompr_24517: compr zstdfast(15) in 4096kB chunks took 17157 us (233 MB/s), compress ratio: 1.84 [ 785.254618] lustre_kcompr_24517: decompr zstdfast(15) took 7097 us (306 MB/s) [ 785.262721] lustre_kcompr_24517: test_comp_compress_decompress(zstdfast,15) ret 0 [ 785.271223] lustre_kcompr_24517: acompr zstdfast(15) of 128kB chunks took 165 us (757 MB/s), compress ratio: 10.73 [ 785.281358] lustre_kcompr_24517: adecompr zstdfast(15) took 109 us (106 MB/s) [ 785.328115] lustre_kcompr_24517: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 785.337552] lustre_kcompr_24517: SUCCESS [ 812.546183] Lustre: DEBUG MARKER: == sanity test complete, duration 541 sec ================ 12:49:24 (1789058964) [ 815.639445] Lustre: DEBUG MARKER: === sanity: start cleanup 12:49:26 (1789058966) === [ 821.196473] Lustre: DEBUG MARKER: === sanity: finish cleanup 12:49:33 (1789058973) === [ 825.551420] LustreError: 14260:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff9f8d48feb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 825.656956] Lustre: Unmounted lustre-client [ 888.721465] Key type lgssc unregistered [ 888.903292] LNet: 14946:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 888.915250] LNetError: 14946:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 888.932382] LNet: Removed LNI 192.168.202.47@tcp [ 889.556110] Key type .llcrypt unregistered [ 889.558674] Key type ._llcrypt unregistered