[ 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 471917893 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001012] APIC: Switch to symmetric I/O mode setup [ 0.003171] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005013] kvm-guest: setup PV IPIs [ 0.007809] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008024] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009018] pid_max: default: 32768 minimum: 301 [ 0.010150] LSM: Security Framework initializing [ 0.011070] Yama: becoming mindful. [ 0.012044] SELinux: Initializing. [ 0.013083] *** VALIDATE selinux *** [ 0.022181] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027092] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028179] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030072] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032029] *** VALIDATE tmpfs *** [ 0.033528] *** VALIDATE proc *** [ 0.034265] *** VALIDATE cgroup *** [ 0.035014] *** VALIDATE cgroup2 *** [ 0.037223] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038160] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.039011] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.040038] Spectre V2 : User space: Vulnerable [ 0.041015] Speculative Store Bypass: Vulnerable [ 0.043704] debug: unmapping init [mem 0xffffffffb2a59000-0xffffffffb2a60fff] [ 0.045193] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046587] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047029] ... version: 2 [ 0.048013] ... bit width: 48 [ 0.048913] ... generic registers: 4 [ 0.049011] ... value mask: 0000ffffffffffff [ 0.050016] ... max period: 00007fffffffffff [ 0.051012] ... fixed-purpose events: 3 [ 0.051916] ... event mask: 000000070000000f [ 0.052320] rcu: Hierarchical SRCU implementation. [ 0.054280] smp: Bringing up secondary CPUs ... [ 0.055669] x86: Booting SMP configuration: [ 0.056026] .... node #0, CPUs: #1 #2 #3 [ 0.060105] smp: Brought up 1 node, 4 CPUs [ 0.061981] smpboot: Max logical packages: 1 [ 0.062010] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.130462] node 0 deferred pages initialised in 66ms [ 0.134561] devtmpfs: initialized [ 0.135259] x86/mm: Memory block size: 128MB [ 0.138152] gcov: version magic: 0x41383552 [ 0.140429] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.144073] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.146387] pinctrl core: initialized pinctrl subsystem [ 0.149192] [ 0.149777] ************************************************************* [ 0.152011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.154015] ** ** [ 0.157015] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.159016] ** ** [ 0.161017] ** This means that this kernel is built to expose internal ** [ 0.163016] ** IOMMU data structures, which may compromise security on ** [ 0.165015] ** your system. ** [ 0.168015] ** ** [ 0.170028] ** If you see this message and you are not debugging the ** [ 0.172020] ** kernel, report this immediately to your vendor! ** [ 0.175016] ** ** [ 0.176011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.178012] ************************************************************* [ 0.180658] NET: Registered protocol family 16 [ 0.183560] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.186064] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.188070] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.191676] cpuidle: using governor menu [ 0.192669] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.194393] PCI: Using configuration type 1 for base access [ 0.195103] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.204084] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.205036] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.207086] cryptd: max_cpu_qlen set to 1000 [ 0.210235] ACPI: Added _OSI(Module Device) [ 0.212011] ACPI: Added _OSI(Processor Device) [ 0.213009] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.214015] ACPI: Added _OSI(Processor Aggregator Device) [ 0.218823] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.225495] ACPI: Interpreter enabled [ 0.226038] ACPI: PM: (supports S0 S3 S4 S5) [ 0.227011] ACPI: Using IOAPIC for interrupt routing [ 0.228085] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.231344] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.239097] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.240028] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.242013] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.244090] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.249553] acpiphp: Slot [2] registered [ 0.250105] acpiphp: Slot [5] registered [ 0.251114] acpiphp: Slot [6] registered [ 0.252095] acpiphp: Slot [3] registered [ 0.254103] acpiphp: Slot [4] registered [ 0.255120] acpiphp: Slot [7] registered [ 0.256089] acpiphp: Slot [8] registered [ 0.256969] acpiphp: Slot [9] registered [ 0.257112] acpiphp: Slot [10] registered [ 0.259163] acpiphp: Slot [11] registered [ 0.260137] acpiphp: Slot [12] registered [ 0.262097] acpiphp: Slot [13] registered [ 0.263092] acpiphp: Slot [14] registered [ 0.264041] acpiphp: Slot [15] registered [ 0.264985] acpiphp: Slot [16] registered [ 0.265060] acpiphp: Slot [17] registered [ 0.265999] acpiphp: Slot [18] registered [ 0.266918] acpiphp: Slot [19] registered [ 0.268055] acpiphp: Slot [20] registered [ 0.268943] acpiphp: Slot [21] registered [ 0.270058] acpiphp: Slot [22] registered [ 0.271054] acpiphp: Slot [23] registered [ 0.272205] acpiphp: Slot [24] registered [ 0.273072] acpiphp: Slot [25] registered [ 0.274071] acpiphp: Slot [26] registered [ 0.275094] acpiphp: Slot [27] registered [ 0.276058] acpiphp: Slot [28] registered [ 0.277066] acpiphp: Slot [29] registered [ 0.278085] acpiphp: Slot [30] registered [ 0.280086] acpiphp: Slot [31] registered [ 0.281060] PCI host bridge to bus 0000:00 [ 0.282020] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.284018] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.285017] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.286014] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.288019] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.289017] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.290193] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.292722] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.295016] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.300840] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.303550] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.305014] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.308017] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.310014] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.311594] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.313638] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.315031] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.317735] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.321015] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.328016] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.332011] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.337304] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.346018] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.351026] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.359850] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.366000] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.373021] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.381019] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.398030] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.410331] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.413438] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.415472] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.418410] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.421269] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.427053] iommu: Default domain type: Passthrough [ 0.429551] SCSI subsystem initialized [ 0.431175] ACPI: bus type USB registered [ 0.432115] usbcore: registered new interface driver usbfs [ 0.434086] usbcore: registered new interface driver hub [ 0.436086] usbcore: registered new device driver usb [ 0.438183] pps_core: LinuxPPS API ver. 1 registered [ 0.440015] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.443070] PTP clock support registered [ 0.445191] EDAC MC: Ver: 3.0.0 [ 0.447118] PCI: Using ACPI for IRQ routing [ 0.449374] NetLabel: Initializing [ 0.451012] NetLabel: domain hash size = 128 [ 0.452013] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.454083] NetLabel: unlabeled traffic allowed by default [ 0.457146] vgaarb: loaded [ 0.458270] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.460014] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.469192] clocksource: Switched to clocksource kvm-clock [ 0.592065] VFS: Disk quotas dquot_6.6.0 [ 0.593829] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.596708] *** VALIDATE ramfs *** [ 0.598135] *** VALIDATE hugetlbfs *** [ 0.599853] pnp: PnP ACPI init [ 0.602555] pnp: PnP ACPI: found 6 devices [ 0.622181] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.625571] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.627847] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.630041] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.632699] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.635158] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.638143] NET: Registered protocol family 2 [ 0.640838] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.646729] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.650791] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.657422] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.661588] TCP: Hash tables configured (established 65536 bind 65536) [ 0.664757] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.667421] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.670120] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.673548] NET: Registered protocol family 1 [ 0.676611] RPC: Registered named UNIX socket transport module. [ 0.679789] RPC: Registered udp transport module. [ 0.681701] RPC: Registered tcp transport module. [ 0.683358] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.685830] NET: Registered protocol family 44 [ 0.687571] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.689850] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.691988] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.694174] PCI: CLS 0 bytes, default 64 [ 0.695975] Unpacking initramfs... [ 2.155786] debug: unmapping init [mem 0xffff8a43fcc64000-0xffff8a43fffcffff] [ 2.160807] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.162745] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.165083] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.665729] Initialise system trusted keyrings [ 2.667034] Key type blacklist registered [ 2.668534] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.677565] zbud: loaded [ 2.680554] *** VALIDATE nfs *** [ 2.681715] *** VALIDATE nfs4 *** [ 2.683251] pstore: using deflate compression [ 2.686279] Platform Keyring initialized [ 2.789949] NET: Registered protocol family 38 [ 2.791296] Key type asymmetric registered [ 2.792358] Asymmetric key parser 'x509' registered [ 2.793633] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.796486] io scheduler mq-deadline registered [ 2.797735] io scheduler kyber registered [ 2.799147] io scheduler bfq registered [ 2.801250] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.804054] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.806601] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.809578] ACPI: Power Button [PWRF] [ 2.814770] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.822637] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.830936] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.860517] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.888552] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.893542] Non-volatile memory driver v1.3 [ 2.895413] Linux agpgart interface v0.103 [ 2.926357] virtio_blk virtio1: [vda] 142768 512-byte logical blocks (73.1 MB/69.7 MiB) [ 2.929234] vda: detected capacity change from 0 to 73097216 [ 2.941774] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.943504] vdb: detected capacity change from 0 to 1073741824 [ 2.947773] libphy: Fixed MDIO Bus: probed [ 2.956624] usbcore: registered new interface driver usbserial_generic [ 2.958708] usbserial: USB Serial support registered for generic [ 2.961054] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.964990] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.966530] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.968729] mousedev: PS/2 mouse device common for all mice [ 2.973546] rtc_cmos 00:05: RTC can wake from S4 [ 2.976841] rtc_cmos 00:05: registered as rtc0 [ 2.978330] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.980157] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.982464] intel_pstate: CPU model not supported [ 2.986118] hid: raw HID events driver (C) Jiri Kosina [ 2.990785] usbcore: registered new interface driver usbhid [ 2.992557] usbhid: USB HID core driver [ 2.993663] drop_monitor: Initializing network drop monitor service [ 2.994992] Initializing XFRM netlink socket [ 2.996667] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.997295] NET: Registered protocol family 10 [ 3.001134] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.002155] Segment Routing with IPv6 [ 3.005709] NET: Registered protocol family 17 [ 3.007180] mpls_gso: MPLS GSO support [ 3.011115] RAS: Correctable Errors collector initialized. [ 3.012455] AVX version of gcm_enc/dec engaged. [ 3.013358] AES CTR mode by8 optimization enabled [ 3.072628] sched_clock: Marking stable (3072610927, 0)->(4112590436, -1039979509) [ 3.075779] registered taskstats version 1 [ 3.077105] Loading compiled-in X.509 certificates [ 3.079156] zswap: loaded using pool lzo/zbud [ 3.103970] Key type big_key registered [ 3.120410] Key type encrypted registered [ 3.122106] ima: No TPM chip found, activating TPM-bypass! [ 3.125035] ima: Allocated hash algorithm: sha1 [ 3.126270] ima: No architecture policies found [ 3.127832] evm: Initialising EVM extended attributes: [ 3.129782] evm: security.selinux [ 3.130795] evm: security.ima [ 3.131538] evm: security.capability [ 3.132523] evm: HMAC attrs: 0x1 [ 3.134285] rtc_cmos 00:05: setting system clock to 2026-09-10 16:26:21 UTC (1789057581) [ 3.138497] debug: unmapping init [mem 0xffffffffb3a03000-0xffffffffb3bfffff] [ 3.140293] debug: unmapping init [mem 0xffffffffb2782000-0xffffffffb2a58fff] [ 3.148119] Write protecting the kernel read-only data: 28672k [ 3.150493] debug: unmapping init [mem 0xffffffffb0e03000-0xffffffffb0ffffff] [ 3.152734] debug: unmapping init [mem 0xffffffffb1714000-0xffffffffb17fffff] [ 3.182204] 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.189592] systemd[1]: Detected virtualization kvm. [ 3.191059] systemd[1]: Detected architecture x86-64. [ 3.192729] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.216647] systemd[1]: No hostname configured. [ 3.217614] systemd[1]: Set hostname to . [ 3.218852] random: systemd: uninitialized urandom read (16 bytes read) [ 3.221682] systemd[1]: Initializing machine ID from random generator. [ 3.368737] random: systemd: uninitialized urandom read (16 bytes read) [ 3.371198] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.374301] random: systemd: uninitialized urandom read (16 bytes read) [ 3.376749] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.379788] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Swap. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. Starting Journal Service... Starting Setup Virtual Console... Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Paths. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.972699] device-mapper: uevent: version 1.0.3 [ 3.974653] 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.589430] scsi host0: ata_piix [ 4.600835] virtio_net virtio0 ens2: renamed from eth0 [ 4.623167] scsi host1: ata_piix [ 4.625248] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.628224] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.360477] dracut-initqueue[576]: RTNETLINK answers: File exists [ 9.637057] random: crng init done [ 9.638968] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 9.978806] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Local Encrypted Volumes. Stopping udev Kernel Device Manager... [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Sockets. [ 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.064753] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.287698] SELinux: Disabled at runtime. [ 11.345443] 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.353687] systemd[1]: Detected virtualization kvm. [ 11.355320] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.783330] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.787249] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.791162] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.795300] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.799759] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.808185] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.814684] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. Activating swap /dev/disk/by-label/SWAP... Mounting POSIX Message Queue File System... Starting Apply Kernel Variables... [ OK ] Reached target rpc_pipefs.target. [ 11.851775] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Mounting Huge Pages File System... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-getty.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Stopped target Initrd Root File System. Starting Remount Root and Kernel File Systems... [ OK ] Created slice User and Session Slice. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Slices. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-serial\x2dgetty.slice. Mounting Kernel Debug File System... [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Huge Pages File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Kernel Debug File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 12.250653] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.519468] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.548918] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.684194] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.696058] EDAC sbridge: Ver: 1.1.2 [ 13.878128] Key type dns_resolver registered [ 14.207772] NFS: Registering the id_resolver key type [ 14.209354] Key type id_resolver registered [ 14.210572] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ 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... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ 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 ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg240-client login: [ 44.069012] hrtimer: interrupt took 4001025 ns [ 70.582093] libcfs: loading out-of-tree module taints kernel. [ 70.756458] Key type ._llcrypt registered [ 70.760980] Key type .llcrypt registered [ 71.753600] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 71.767161] alg: No test for adler32 (adler32-zlib) [ 72.891587] Lustre: Lustre: Build Version: 2.17.53_26_gdb05832 [ 73.640731] LNet: Added LNI 192.168.202.40@tcp [8/256/0/180] [ 75.383181] Key type lgssc registered [ 77.911878] Lustre: Echo OBD driver; http://www.lustre.org/ [ 85.731069] alg: No test for zstdfast (zstdfast-lustre-generic) [ 85.755403] alg: No test for zstdfast (zstdfast-lustre-scomp) [ 254.142479] Lustre: Mounted lustre-client [ 261.025877] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 276.516132] Lustre: DEBUG MARKER: oleg240-client.virtnet: executing check_logdir /tmp/testlogs/ [ 280.031339] Lustre: lustre-OST0000-osc-ffff8a445153f800: disconnect after 23s idle [ 282.654928] Lustre: DEBUG MARKER: oleg240-client.virtnet: executing yml_node [ 287.422279] Lustre: DEBUG MARKER: Client: 2.17.53.26 [ 289.890501] Lustre: DEBUG MARKER: MDS: 2.17.53.26 [ 292.677761] Lustre: DEBUG MARKER: OSS: 2.17.53.26 [ 294.367397] Lustre: DEBUG MARKER: -----============= acceptance-small: sanity ============----- Thu Sep 10 12:31:11 EDT 2026 [ 316.679843] Lustre: DEBUG MARKER: - need MDS1_VERSION <= 2.16.61-1-g89cf292a8c2 (34682138 <= 34618625) for LU-18938, skip 360 [ 319.141569] Lustre: DEBUG MARKER: - need MDS1_VERSION < v2_14_55-100-g8a84c7f9c7 (34682138 < 34486116) for LU-14927, skip 0f [ 321.856313] Lustre: DEBUG MARKER: excepting tests: 42a 42c 42b 118c 118d 407 119i 817 411a 130b 130c 130d 130e 130f 130g [ 324.241486] Lustre: DEBUG MARKER: skipping tests SLOW=no: 27m 60i 64b 68 71 135 136 230d 300o 842 51b 51c 51e 834 [ 326.897714] Lustre: DEBUG MARKER: === sanity: start setup 12:31:42 (1789057902) === [ 331.256909] Lustre: DEBUG MARKER: oleg240-client.virtnet: executing check_config_client /mnt/lustre [ 355.355179] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 368.391322] Lustre: DEBUG MARKER: === sanity: finish setup 12:32:24 (1789057944) === [ 377.031467] Lustre: DEBUG MARKER: == sanity test 84: lz4/lz4hc/lzstd compression/decompression kernel module ========================================================== 12:32:33 (1789057953) [ 378.039991] lustre_kcompr_22317: ***** [ 378.042965] lustre_kcompr_22317: (de)compression test on random binary data [ 378.046446] lustre_kcompr_22317: ***** [ 378.060660] lustre_kcompr_22317: compr lz4(1) in 64kB chunks took 3434 us (1164 MB/s), compress ratio: 95.20 [ 378.066530] lustre_kcompr_22317: compr lz4(1) in 128kB chunks took 2330 us (1716 MB/s), compress ratio: 100.12 [ 378.074263] lustre_kcompr_22317: compr lz4(1) in 256kB chunks took 1395 us (2867 MB/s), compress ratio: 103.34 [ 378.081853] lustre_kcompr_22317: compr lz4(1) in 512kB chunks took 1768 us (2262 MB/s), compress ratio: 104.72 [ 378.093988] lustre_kcompr_22317: compr lz4(1) in 1024kB chunks took 3517 us (1137 MB/s), compress ratio: 105.38 [ 378.103701] lustre_kcompr_22317: compr lz4(1) in 2048kB chunks took 3113 us (1284 MB/s), compress ratio: 105.95 [ 378.111750] lustre_kcompr_22317: compr lz4(1) in 4096kB chunks took 1441 us (2775 MB/s), compress ratio: 106.19 [ 378.126689] lustre_kcompr_22317: decompr lz4(1) took 3812 us (9 MB/s) [ 378.130687] lustre_kcompr_22317: test_comp_compress_decompress(lz4,1) ret 0 [ 378.134256] lustre_kcompr_22317: acompr lz4(1) of 128kB chunks took 67 us (1865 MB/s), compress ratio: 108.95 [ 378.137779] lustre_kcompr_22317: adecompr lz4(1) took 125 us (9 MB/s) [ 378.141591] lustre_kcompr_22317: test_acomp_compress_decompress(lz4,1) ret 0 [ 378.152414] lustre_kcompr_22317: compr lz4(4) in 64kB chunks took 1729 us (2313 MB/s), compress ratio: 81.59 [ 378.156955] lustre_kcompr_22317: compr lz4(4) in 128kB chunks took 1464 us (2732 MB/s), compress ratio: 91.11 [ 378.165660] lustre_kcompr_22317: compr lz4(4) in 256kB chunks took 4417 us (905 MB/s), compress ratio: 97.81 [ 378.172507] lustre_kcompr_22317: compr lz4(4) in 512kB chunks took 1838 us (2176 MB/s), compress ratio: 100.70 [ 378.182814] lustre_kcompr_22317: compr lz4(4) in 1024kB chunks took 1156 us (3460 MB/s), compress ratio: 102.71 [ 378.191166] lustre_kcompr_22317: compr lz4(4) in 2048kB chunks took 1684 us (2375 MB/s), compress ratio: 103.54 [ 378.196311] lustre_kcompr_22317: compr lz4(4) in 4096kB chunks took 1284 us (3115 MB/s), compress ratio: 103.71 [ 378.220544] lustre_kcompr_22317: decompr lz4(4) took 2852 us (13 MB/s) [ 378.224413] lustre_kcompr_22317: test_comp_compress_decompress(lz4,4) ret 0 [ 378.228336] lustre_kcompr_22317: acompr lz4(4) of 128kB chunks took 374 us (334 MB/s), compress ratio: 94.43 [ 378.232356] lustre_kcompr_22317: adecompr lz4(4) took 110 us (12 MB/s) [ 378.236826] lustre_kcompr_22317: test_acomp_compress_decompress(lz4,4) ret 0 [ 378.249430] lustre_kcompr_22317: compr lz4(9) in 64kB chunks took 1895 us (2110 MB/s), compress ratio: 60.88 [ 378.257327] lustre_kcompr_22317: compr lz4(9) in 128kB chunks took 3366 us (1188 MB/s), compress ratio: 74.37 [ 378.272826] lustre_kcompr_22317: compr lz4(9) in 256kB chunks took 3640 us (1098 MB/s), compress ratio: 85.69 [ 378.284846] lustre_kcompr_22317: compr lz4(9) in 512kB chunks took 2281 us (1753 MB/s), compress ratio: 93.34 [ 378.291323] lustre_kcompr_22317: compr lz4(9) in 1024kB chunks took 1699 us (2354 MB/s), compress ratio: 97.38 [ 378.297537] lustre_kcompr_22317: compr lz4(9) in 2048kB chunks took 1931 us (2071 MB/s), compress ratio: 98.84 [ 378.306297] lustre_kcompr_22317: compr lz4(9) in 4096kB chunks took 1572 us (2544 MB/s), compress ratio: 100.42 [ 378.319322] lustre_kcompr_22317: decompr lz4(9) took 1866 us (21 MB/s) [ 378.321811] lustre_kcompr_22317: test_comp_compress_decompress(lz4,9) ret 0 [ 378.324591] lustre_kcompr_22317: acompr lz4(9) of 128kB chunks took 66 us (1893 MB/s), compress ratio: 77.37 [ 378.328303] lustre_kcompr_22317: adecompr lz4(9) took 285 us (5 MB/s) [ 378.332758] lustre_kcompr_22317: test_acomp_compress_decompress(lz4,9) ret 0 [ 378.346283] lustre_kcompr_22317: compr lz4(15) in 64kB chunks took 2932 us (1364 MB/s), compress ratio: 29.33 [ 378.355790] lustre_kcompr_22317: compr lz4(15) in 128kB chunks took 2459 us (1626 MB/s), compress ratio: 42.97 [ 378.366553] lustre_kcompr_22317: compr lz4(15) in 256kB chunks took 2209 us (1810 MB/s), compress ratio: 57.07 [ 378.372065] lustre_kcompr_22317: compr lz4(15) in 512kB chunks took 2002 us (1998 MB/s), compress ratio: 68.65 [ 378.377345] lustre_kcompr_22317: compr lz4(15) in 1024kB chunks took 2165 us (1847 MB/s), compress ratio: 78.02 [ 378.382932] lustre_kcompr_22317: compr lz4(15) in 2048kB chunks took 2353 us (1699 MB/s), compress ratio: 82.35 [ 378.388661] lustre_kcompr_22317: compr lz4(15) in 4096kB chunks took 2180 us (1834 MB/s), compress ratio: 85.44 [ 378.403494] lustre_kcompr_22317: decompr lz4(15) took 2897 us (16 MB/s) [ 378.406955] lustre_kcompr_22317: test_comp_compress_decompress(lz4,15) ret 0 [ 378.410143] lustre_kcompr_22317: acompr lz4(15) of 128kB chunks took 190 us (657 MB/s), compress ratio: 40.00 [ 378.421057] lustre_kcompr_22317: adecompr lz4(15) took 110 us (28 MB/s) [ 378.426511] lustre_kcompr_22317: test_acomp_compress_decompress(lz4,15) ret 0 [ 378.471543] lustre_kcompr_22317: compr lz4hc(1) in 64kB chunks took 29991 us (133 MB/s), compress ratio: 96.38 [ 378.500488] lustre_kcompr_22317: compr lz4hc(1) in 128kB chunks took 23514 us (170 MB/s), compress ratio: 102.13 [ 378.531501] lustre_kcompr_22317: compr lz4hc(1) in 256kB chunks took 25656 us (155 MB/s), compress ratio: 105.29 [ 378.562105] lustre_kcompr_22317: compr lz4hc(1) in 512kB chunks took 25970 us (154 MB/s), compress ratio: 106.91 [ 378.595316] lustre_kcompr_22317: compr lz4hc(1) in 1024kB chunks took 26887 us (148 MB/s), compress ratio: 107.75 [ 378.631169] lustre_kcompr_22317: compr lz4hc(1) in 2048kB chunks took 30682 us (130 MB/s), compress ratio: 108.17 [ 378.663064] lustre_kcompr_22317: compr lz4hc(1) in 4096kB chunks took 26755 us (149 MB/s), compress ratio: 108.38 [ 378.676557] lustre_kcompr_22317: decompr lz4hc(1) took 1904 us (19 MB/s) [ 378.681527] lustre_kcompr_22317: test_comp_compress_decompress(lz4hc,1) ret 0 [ 378.687374] lustre_kcompr_22317: acompr lz4hc(1) of 128kB chunks took 1251 us (99 MB/s), compress ratio: 109.77 [ 378.692622] lustre_kcompr_22317: adecompr lz4hc(1) took 177 us (6 MB/s) [ 378.698121] lustre_kcompr_22317: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 378.750738] lustre_kcompr_22317: compr lz4hc(3) in 64kB chunks took 40114 us (99 MB/s), compress ratio: 96.94 [ 378.797553] lustre_kcompr_22317: compr lz4hc(3) in 128kB chunks took 41217 us (97 MB/s), compress ratio: 102.75 [ 378.845272] lustre_kcompr_22317: compr lz4hc(3) in 256kB chunks took 42597 us (93 MB/s), compress ratio: 105.95 [ 378.893538] lustre_kcompr_22317: compr lz4hc(3) in 512kB chunks took 41979 us (95 MB/s), compress ratio: 107.58 [ 378.933818] lustre_kcompr_22317: compr lz4hc(3) in 1024kB chunks took 36177 us (110 MB/s), compress ratio: 108.43 [ 378.981235] lustre_kcompr_22317: compr lz4hc(3) in 2048kB chunks took 42640 us (93 MB/s), compress ratio: 108.86 [ 379.027151] lustre_kcompr_22317: compr lz4hc(3) in 4096kB chunks took 37444 us (106 MB/s), compress ratio: 109.07 [ 379.039919] lustre_kcompr_22317: decompr lz4hc(3) took 2221 us (16 MB/s) [ 379.044646] lustre_kcompr_22317: test_comp_compress_decompress(lz4hc,3) ret 0 [ 379.048979] lustre_kcompr_22317: acompr lz4hc(3) of 128kB chunks took 1036 us (120 MB/s), compress ratio: 110.14 [ 379.054409] lustre_kcompr_22317: adecompr lz4hc(3) took 188 us (6 MB/s) [ 379.072636] lustre_kcompr_22317: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 380.251460] lustre_kcompr_22317: compr lz4hc(8) in 64kB chunks took 1155947 us (3 MB/s), compress ratio: 103.32 [ 381.476274] lustre_kcompr_22317: compr lz4hc(8) in 128kB chunks took 1210327 us (3 MB/s), compress ratio: 110.24 [ 382.777976] lustre_kcompr_22317: compr lz4hc(8) in 256kB chunks took 1298565 us (3 MB/s), compress ratio: 114.09 [ 384.639808] lustre_kcompr_22317: compr lz4hc(8) in 512kB chunks took 1853178 us (2 MB/s), compress ratio: 116.06 [ 385.314617] lustre_kcompr_22317: compr lz4hc(8) in 1024kB chunks took 661955 us (6 MB/s), compress ratio: 117.06 [ 386.829144] lustre_kcompr_22317: compr lz4hc(8) in 2048kB chunks took 1507197 us (2 MB/s), compress ratio: 117.58 [ 388.092938] lustre_kcompr_22317: compr lz4hc(8) in 4096kB chunks took 1260449 us (3 MB/s), compress ratio: 117.83 [ 388.132112] lustre_kcompr_22317: decompr lz4hc(8) took 3009 us (11 MB/s) [ 388.139265] lustre_kcompr_22317: test_comp_compress_decompress(lz4hc,8) ret 0 [ 388.187966] lustre_kcompr_22317: acompr lz4hc(8) of 128kB chunks took 33661 us (3 MB/s), compress ratio: 118.50 [ 388.193880] lustre_kcompr_22317: adecompr lz4hc(8) took 100 us (10 MB/s) [ 388.200653] lustre_kcompr_22317: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 389.438982] lustre_kcompr_22317: compr lz4hc(15) in 64kB chunks took 1207176 us (3 MB/s), compress ratio: 103.96 [ 390.665226] lustre_kcompr_22317: compr lz4hc(15) in 128kB chunks took 1219128 us (3 MB/s), compress ratio: 111.35 [ 392.256175] lustre_kcompr_22317: compr lz4hc(15) in 256kB chunks took 1565106 us (2 MB/s), compress ratio: 115.45 [ 392.673861] Lustre: lustre-OST0001-osc-ffff8a445153f800: disconnect after 24s idle [ 392.684940] Lustre: Skipped 1 previous similar message [ 393.582322] lustre_kcompr_22317: compr lz4hc(15) in 512kB chunks took 1318928 us (3 MB/s), compress ratio: 117.59 [ 395.114299] lustre_kcompr_22317: compr lz4hc(15) in 1024kB chunks took 1525676 us (2 MB/s), compress ratio: 118.67 [ 396.246432] lustre_kcompr_22317: compr lz4hc(15) in 2048kB chunks took 1129330 us (3 MB/s), compress ratio: 119.25 [ 397.094838] lustre_kcompr_22317: compr lz4hc(15) in 4096kB chunks took 840610 us (4 MB/s), compress ratio: 119.51 [ 397.115970] lustre_kcompr_22317: decompr lz4hc(15) took 3183 us (10 MB/s) [ 397.121103] lustre_kcompr_22317: test_comp_compress_decompress(lz4hc,15) ret 0 [ 397.145405] lustre_kcompr_22317: acompr lz4hc(15) of 128kB chunks took 18809 us (6 MB/s), compress ratio: 119.70 [ 397.151049] lustre_kcompr_22317: adecompr lz4hc(15) took 133 us (7 MB/s) [ 397.160961] lustre_kcompr_22317: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 397.175170] lustre_kcompr_22317: compr lzo(-1) in 64kB chunks took 5778 us (692 MB/s), compress ratio: 80.25 [ 397.185807] lustre_kcompr_22317: compr lzo(-1) in 128kB chunks took 3874 us (1032 MB/s), compress ratio: 85.27 [ 397.198993] lustre_kcompr_22317: compr lzo(-1) in 256kB chunks took 6433 us (621 MB/s), compress ratio: 85.16 [ 397.209393] lustre_kcompr_22317: compr lzo(-1) in 512kB chunks took 4350 us (919 MB/s), compress ratio: 86.68 [ 397.221317] lustre_kcompr_22317: compr lzo(-1) in 1024kB chunks took 6757 us (591 MB/s), compress ratio: 87.16 [ 397.234980] lustre_kcompr_22317: compr lzo(-1) in 2048kB chunks took 3962 us (1009 MB/s), compress ratio: 87.72 [ 397.242486] lustre_kcompr_22317: compr lzo(-1) in 4096kB chunks took 2145 us (1864 MB/s), compress ratio: 87.64 [ 397.265457] lustre_kcompr_22317: decompr lzo(-1) took 6096 us (7 MB/s) [ 397.283402] lustre_kcompr_22317: test_comp_compress_decompress(lzo,-1) ret 0 [ 397.297168] lustre_kcompr_22317: acompr lzo(-1) of 128kB chunks took 185 us (675 MB/s), compress ratio: 96.30 [ 397.303518] lustre_kcompr_22317: adecompr lzo(-1) took 1303 us (0 MB/s) [ 397.366485] lustre_kcompr_22317: test_acomp_compress_decompress(lzo,-1) ret 0 [ 397.951270] lustre_kcompr_22317: compr deflate(1) in 64kB chunks took 561435 us (7 MB/s), compress ratio: 96.57 [ 398.630968] lustre_kcompr_22317: compr deflate(1) in 128kB chunks took 672175 us (5 MB/s), compress ratio: 106.67 [ 399.514217] lustre_kcompr_22317: compr deflate(1) in 256kB chunks took 870786 us (4 MB/s), compress ratio: 112.86 [ 400.271602] lustre_kcompr_22317: compr deflate(1) in 512kB chunks took 749650 us (5 MB/s), compress ratio: 116.68 [ 400.927073] lustre_kcompr_22317: compr deflate(1) in 1024kB chunks took 645566 us (6 MB/s), compress ratio: 118.59 [ 401.360246] lustre_kcompr_22317: compr deflate(1) in 2048kB chunks took 408583 us (9 MB/s), compress ratio: 119.51 [ 401.810766] lustre_kcompr_22317: compr deflate(1) in 4096kB chunks took 440984 us (9 MB/s), compress ratio: 119.77 [ 401.848796] lustre_kcompr_22317: decompr deflate(1) took 14543 us (2 MB/s) [ 401.861299] lustre_kcompr_22317: test_comp_compress_decompress(deflate,1) ret 0 [ 401.879967] lustre_kcompr_22317: acompr deflate(1) of 128kB chunks took 10133 us (12 MB/s), compress ratio: 114.67 [ 401.885700] lustre_kcompr_22317: adecompr deflate(1) took 215 us (5 MB/s) [ 401.895550] lustre_kcompr_22317: test_acomp_compress_decompress(deflate,1) ret 0 [ 402.334701] lustre_kcompr_22317: compr deflate(6) in 64kB chunks took 415795 us (9 MB/s), compress ratio: 96.57 [ 402.909120] lustre_kcompr_22317: compr deflate(6) in 128kB chunks took 569721 us (7 MB/s), compress ratio: 106.67 [ 403.519954] lustre_kcompr_22317: compr deflate(6) in 256kB chunks took 597340 us (6 MB/s), compress ratio: 112.86 [ 404.191192] lustre_kcompr_22317: compr deflate(6) in 512kB chunks took 661131 us (6 MB/s), compress ratio: 116.68 [ 404.829572] lustre_kcompr_22317: compr deflate(6) in 1024kB chunks took 623490 us (6 MB/s), compress ratio: 118.59 [ 405.456861] lustre_kcompr_22317: compr deflate(6) in 2048kB chunks took 600076 us (6 MB/s), compress ratio: 119.51 [ 406.161367] lustre_kcompr_22317: compr deflate(6) in 4096kB chunks took 690162 us (5 MB/s), compress ratio: 119.77 [ 406.197836] lustre_kcompr_22317: decompr deflate(6) took 13895 us (2 MB/s) [ 406.224226] lustre_kcompr_22317: test_comp_compress_decompress(deflate,6) ret 0 [ 406.252079] lustre_kcompr_22317: acompr deflate(6) of 128kB chunks took 12506 us (9 MB/s), compress ratio: 114.67 [ 406.262454] lustre_kcompr_22317: adecompr deflate(6) took 295 us (3 MB/s) [ 406.279528] lustre_kcompr_22317: test_acomp_compress_decompress(deflate,6) ret 0 [ 406.974716] lustre_kcompr_22317: compr deflate(9) in 64kB chunks took 662326 us (6 MB/s), compress ratio: 96.57 [ 407.598720] lustre_kcompr_22317: compr deflate(9) in 128kB chunks took 608181 us (6 MB/s), compress ratio: 106.67 [ 408.189597] lustre_kcompr_22317: compr deflate(9) in 256kB chunks took 581724 us (6 MB/s), compress ratio: 112.86 [ 408.972563] lustre_kcompr_22317: compr deflate(9) in 512kB chunks took 769490 us (5 MB/s), compress ratio: 116.68 [ 409.510664] lustre_kcompr_22317: compr deflate(9) in 1024kB chunks took 528994 us (7 MB/s), compress ratio: 118.59 [ 410.166507] lustre_kcompr_22317: compr deflate(9) in 2048kB chunks took 649912 us (6 MB/s), compress ratio: 119.51 [ 410.935390] lustre_kcompr_22317: compr deflate(9) in 4096kB chunks took 747613 us (5 MB/s), compress ratio: 119.77 [ 411.005507] lustre_kcompr_22317: decompr deflate(9) took 22281 us (1 MB/s) [ 411.039312] lustre_kcompr_22317: test_comp_compress_decompress(deflate,9) ret 0 [ 411.092111] lustre_kcompr_22317: acompr deflate(9) of 128kB chunks took 42802 us (2 MB/s), compress ratio: 114.67 [ 411.128639] lustre_kcompr_22317: adecompr deflate(9) took 243 us (4 MB/s) [ 411.164769] lustre_kcompr_22317: test_acomp_compress_decompress(deflate,9) ret 0 [ 411.254884] lustre_kcompr_22317: compr zstd(0) in 64kB chunks took 33564 us (119 MB/s), compress ratio: 156.06 [ 411.315778] lustre_kcompr_22317: compr zstd(0) in 128kB chunks took 54831 us (72 MB/s), compress ratio: 188.77 [ 411.395231] lustre_kcompr_22317: compr zstd(0) in 256kB chunks took 68061 us (58 MB/s), compress ratio: 200.90 [ 411.507632] lustre_kcompr_22317: compr zstd(0) in 512kB chunks took 80840 us (49 MB/s), compress ratio: 207.16 [ 411.539019] lustre_kcompr_22317: compr zstd(0) in 1024kB chunks took 16288 us (245 MB/s), compress ratio: 209.71 [ 411.584692] lustre_kcompr_22317: compr zstd(0) in 2048kB chunks took 23315 us (171 MB/s), compress ratio: 211.26 [ 411.627966] lustre_kcompr_22317: compr zstd(0) in 4096kB chunks took 28867 us (138 MB/s), compress ratio: 211.32 [ 411.678712] lustre_kcompr_22317: decompr zstd(0) took 11416 us (1 MB/s) [ 411.690213] lustre_kcompr_22317: test_comp_compress_decompress(zstd,0) ret 0 [ 411.697298] lustre_kcompr_22317: acompr zstd(0) of 128kB chunks took 250 us (500 MB/s), compress ratio: 211.06 [ 411.707264] lustre_kcompr_22317: adecompr zstd(0) took 145 us (4 MB/s) [ 411.719783] lustre_kcompr_22317: test_acomp_compress_decompress(zstd,0) ret 0 [ 411.771465] lustre_kcompr_22317: compr zstd(1) in 64kB chunks took 9682 us (413 MB/s), compress ratio: 155.18 [ 411.782212] lustre_kcompr_22317: compr zstd(1) in 128kB chunks took 5508 us (726 MB/s), compress ratio: 185.49 [ 411.805535] lustre_kcompr_22317: compr zstd(1) in 256kB chunks took 8988 us (445 MB/s), compress ratio: 197.11 [ 411.837436] lustre_kcompr_22317: compr zstd(1) in 512kB chunks took 8896 us (449 MB/s), compress ratio: 204.07 [ 411.852936] lustre_kcompr_22317: compr zstd(1) in 1024kB chunks took 6811 us (587 MB/s), compress ratio: 206.62 [ 411.865417] lustre_kcompr_22317: compr zstd(1) in 2048kB chunks took 3690 us (1084 MB/s), compress ratio: 207.41 [ 411.874222] lustre_kcompr_22317: compr zstd(1) in 4096kB chunks took 4436 us (901 MB/s), compress ratio: 207.36 [ 411.892434] lustre_kcompr_22317: decompr zstd(1) took 4987 us (3 MB/s) [ 411.913036] lustre_kcompr_22317: test_comp_compress_decompress(zstd,1) ret 0 [ 411.923895] lustre_kcompr_22317: acompr zstd(1) of 128kB chunks took 150 us (833 MB/s), compress ratio: 197.39 [ 411.933665] lustre_kcompr_22317: adecompr zstd(1) took 112 us (5 MB/s) [ 411.947765] lustre_kcompr_22317: test_acomp_compress_decompress(zstd,1) ret 0 [ 412.280309] lustre_kcompr_22317: compr zstd(10) in 64kB chunks took 310081 us (12 MB/s), compress ratio: 158.01 [ 412.655954] lustre_kcompr_22317: compr zstd(10) in 128kB chunks took 354951 us (11 MB/s), compress ratio: 180.05 [ 413.076863] lustre_kcompr_22317: compr zstd(10) in 256kB chunks took 412992 us (9 MB/s), compress ratio: 191.06 [ 413.292816] lustre_kcompr_22317: compr zstd(10) in 512kB chunks took 200776 us (19 MB/s), compress ratio: 212.07 [ 413.590396] lustre_kcompr_22317: compr zstd(10) in 1024kB chunks took 286943 us (13 MB/s), compress ratio: 215.93 [ 413.897590] lustre_kcompr_22317: compr zstd(10) in 2048kB chunks took 291306 us (13 MB/s), compress ratio: 217.97 [ 413.984628] lustre_kcompr_22317: compr zstd(10) in 4096kB chunks took 84023 us (47 MB/s), compress ratio: 218.93 [ 414.008085] lustre_kcompr_22317: decompr zstd(10) took 3422 us (5 MB/s) [ 414.031089] lustre_kcompr_22317: test_comp_compress_decompress(zstd,10) ret 0 [ 414.055991] lustre_kcompr_22317: acompr zstd(10) of 128kB chunks took 9321 us (13 MB/s), compress ratio: 201.95 [ 414.062360] lustre_kcompr_22317: adecompr zstd(10) took 101 us (6 MB/s) [ 414.082442] lustre_kcompr_22317: test_acomp_compress_decompress(zstd,10) ret 0 [ 414.807654] lustre_kcompr_22317: compr zstd(15) in 64kB chunks took 703299 us (5 MB/s), compress ratio: 166.55 [ 415.973402] lustre_kcompr_22317: compr zstd(15) in 128kB chunks took 1161420 us (3 MB/s), compress ratio: 190.96 [ 416.482410] lustre_kcompr_22317: compr zstd(15) in 256kB chunks took 503816 us (7 MB/s), compress ratio: 203.71 [ 417.121252] lustre_kcompr_22317: compr zstd(15) in 512kB chunks took 632449 us (6 MB/s), compress ratio: 210.39 [ 418.137661] lustre_kcompr_22317: compr zstd(15) in 1024kB chunks took 1007906 us (3 MB/s), compress ratio: 213.37 [ 420.086501] lustre_kcompr_22317: compr zstd(15) in 2048kB chunks took 1945074 us (2 MB/s), compress ratio: 215.56 [ 422.770368] lustre_kcompr_22317: compr zstd(15) in 4096kB chunks took 2677617 us (1 MB/s), compress ratio: 215.71 [ 422.825422] lustre_kcompr_22317: decompr zstd(15) took 20857 us (0 MB/s) [ 422.849822] lustre_kcompr_22317: test_comp_compress_decompress(zstd,15) ret 0 [ 422.914795] lustre_kcompr_22317: acompr zstd(15) of 128kB chunks took 42854 us (2 MB/s), compress ratio: 214.52 [ 422.923984] lustre_kcompr_22317: adecompr zstd(15) took 214 us (2 MB/s) [ 422.960882] lustre_kcompr_22317: test_acomp_compress_decompress(zstd,15) ret 0 [ 423.014936] lustre_kcompr_22317: compr zstdfast(1) in 64kB chunks took 17013 us (235 MB/s), compress ratio: 155.21 [ 423.044144] lustre_kcompr_22317: compr zstdfast(1) in 128kB chunks took 10328 us (387 MB/s), compress ratio: 185.53 [ 423.096720] lustre_kcompr_22317: compr zstdfast(1) in 256kB chunks took 16686 us (239 MB/s), compress ratio: 197.17 [ 423.120911] lustre_kcompr_22317: compr zstdfast(1) in 512kB chunks took 5023 us (796 MB/s), compress ratio: 204.00 [ 423.135149] lustre_kcompr_22317: compr zstdfast(1) in 1024kB chunks took 2301 us (1738 MB/s), compress ratio: 205.85 [ 423.148035] lustre_kcompr_22317: compr zstdfast(1) in 2048kB chunks took 2134 us (1874 MB/s), compress ratio: 206.11 [ 423.172761] lustre_kcompr_22317: compr zstdfast(1) in 4096kB chunks took 8833 us (452 MB/s), compress ratio: 205.98 [ 423.200841] lustre_kcompr_22317: decompr zstdfast(1) took 4851 us (4 MB/s) [ 423.208068] lustre_kcompr_22317: test_comp_compress_decompress(zstdfast,1) ret 0 [ 423.213846] lustre_kcompr_22317: acompr zstdfast(1) of 128kB chunks took 153 us (816 MB/s), compress ratio: 197.39 [ 423.221707] lustre_kcompr_22317: adecompr zstdfast(1) took 122 us (5 MB/s) [ 423.295927] lustre_kcompr_22317: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 423.343200] lustre_kcompr_22317: compr zstdfast(5) in 64kB chunks took 7734 us (517 MB/s), compress ratio: 137.22 [ 423.360746] lustre_kcompr_22317: compr zstdfast(5) in 128kB chunks took 5541 us (721 MB/s), compress ratio: 161.55 [ 423.401367] lustre_kcompr_22317: compr zstdfast(5) in 256kB chunks took 6437 us (621 MB/s), compress ratio: 169.89 [ 423.428918] lustre_kcompr_22317: compr zstdfast(5) in 512kB chunks took 18105 us (220 MB/s), compress ratio: 174.66 [ 423.452544] lustre_kcompr_22317: compr zstdfast(5) in 1024kB chunks took 10232 us (390 MB/s), compress ratio: 175.81 [ 423.472872] lustre_kcompr_22317: compr zstdfast(5) in 2048kB chunks took 9547 us (418 MB/s), compress ratio: 176.40 [ 423.508857] lustre_kcompr_22317: compr zstdfast(5) in 4096kB chunks took 22110 us (180 MB/s), compress ratio: 177.12 [ 423.558995] lustre_kcompr_22317: decompr zstdfast(5) took 5405 us (4 MB/s) [ 423.586414] lustre_kcompr_22317: test_comp_compress_decompress(zstdfast,5) ret 0 [ 423.595038] lustre_kcompr_22317: acompr zstdfast(5) of 128kB chunks took 1644 us (76 MB/s), compress ratio: 175.69 [ 423.610868] lustre_kcompr_22317: adecompr zstdfast(5) took 110 us (6 MB/s) [ 423.646372] lustre_kcompr_22317: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 423.690859] lustre_kcompr_22317: compr zstdfast(12) in 64kB chunks took 15607 us (256 MB/s), compress ratio: 37.30 [ 423.712183] lustre_kcompr_22317: compr zstdfast(12) in 128kB chunks took 2000 us (2000 MB/s), compress ratio: 42.37 [ 423.726606] lustre_kcompr_22317: compr zstdfast(12) in 256kB chunks took 2050 us (1951 MB/s), compress ratio: 44.78 [ 423.737374] lustre_kcompr_22317: compr zstdfast(12) in 512kB chunks took 4714 us (848 MB/s), compress ratio: 47.50 [ 423.773079] lustre_kcompr_22317: compr zstdfast(12) in 1024kB chunks took 1904 us (2100 MB/s), compress ratio: 54.30 [ 423.790736] lustre_kcompr_22317: compr zstdfast(12) in 2048kB chunks took 1905 us (2099 MB/s), compress ratio: 74.47 [ 423.801563] lustre_kcompr_22317: compr zstdfast(12) in 4096kB chunks took 1861 us (2149 MB/s), compress ratio: 77.72 [ 423.840735] lustre_kcompr_22317: decompr zstdfast(12) took 7603 us (6 MB/s) [ 423.856491] lustre_kcompr_22317: test_comp_compress_decompress(zstdfast,12) ret 0 [ 423.861595] lustre_kcompr_22317: acompr zstdfast(12) of 128kB chunks took 208 us (600 MB/s), compress ratio: 47.16 [ 423.865646] lustre_kcompr_22317: adecompr zstdfast(12) took 181 us (14 MB/s) [ 423.883273] lustre_kcompr_22317: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 423.967145] lustre_kcompr_22317: compr zstdfast(15) in 64kB chunks took 16771 us (238 MB/s), compress ratio: 18.74 [ 424.012979] lustre_kcompr_22317: compr zstdfast(15) in 128kB chunks took 10776 us (371 MB/s), compress ratio: 19.74 [ 424.038716] lustre_kcompr_22317: compr zstdfast(15) in 256kB chunks took 15879 us (251 MB/s), compress ratio: 21.36 [ 424.054482] lustre_kcompr_22317: compr zstdfast(15) in 512kB chunks took 1974 us (2026 MB/s), compress ratio: 23.31 [ 424.085763] lustre_kcompr_22317: compr zstdfast(15) in 1024kB chunks took 12398 us (322 MB/s), compress ratio: 25.97 [ 424.104783] lustre_kcompr_22317: compr zstdfast(15) in 2048kB chunks took 6972 us (573 MB/s), compress ratio: 32.04 [ 424.121056] lustre_kcompr_22317: compr zstdfast(15) in 4096kB chunks took 6017 us (664 MB/s), compress ratio: 33.16 [ 424.167823] lustre_kcompr_22317: decompr zstdfast(15) took 1866 us (64 MB/s) [ 424.185928] lustre_kcompr_22317: test_comp_compress_decompress(zstdfast,15) ret 0 [ 424.198970] lustre_kcompr_22317: acompr zstdfast(15) of 128kB chunks took 185 us (675 MB/s), compress ratio: 20.28 [ 424.211855] lustre_kcompr_22317: adecompr zstdfast(15) took 364 us (16 MB/s) [ 424.282776] lustre_kcompr_22317: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 424.305376] lustre_kcompr_22317: SUCCESS [ 437.625876] lustre_kcompr_30149: ***** [ 437.630867] lustre_kcompr_30149: (de)compression test on provided file /tmp/f84.sanity [ 437.656172] lustre_kcompr_30149: ***** [ 437.694863] lustre_kcompr_30149: compr lz4(1) in 64kB chunks took 23204 us (172 MB/s), compress ratio: 2.93 [ 437.733777] lustre_kcompr_30149: compr lz4(1) in 128kB chunks took 30064 us (133 MB/s), compress ratio: 3.04 [ 437.799848] lustre_kcompr_30149: compr lz4(1) in 256kB chunks took 54845 us (72 MB/s), compress ratio: 3.08 [ 437.867088] lustre_kcompr_30149: compr lz4(1) in 512kB chunks took 51688 us (77 MB/s), compress ratio: 3.10 [ 437.913942] lustre_kcompr_30149: compr lz4(1) in 1024kB chunks took 42178 us (94 MB/s), compress ratio: 3.11 [ 437.980143] lustre_kcompr_30149: compr lz4(1) in 2048kB chunks took 55599 us (71 MB/s), compress ratio: 3.11 [ 438.031614] lustre_kcompr_30149: compr lz4(1) in 4096kB chunks took 43887 us (91 MB/s), compress ratio: 3.12 [ 438.052748] lustre_kcompr_30149: decompr lz4(1) took 6519 us (196 MB/s) [ 438.058792] lustre_kcompr_30149: test_comp_compress_decompress(lz4,1) ret 0 [ 438.067612] lustre_kcompr_30149: acompr lz4(1) of 128kB chunks took 1655 us (75 MB/s), compress ratio: 2.68 [ 438.073483] lustre_kcompr_30149: adecompr lz4(1) took 252 us (184 MB/s) [ 438.095345] lustre_kcompr_30149: test_acomp_compress_decompress(lz4,1) ret 0 [ 438.143267] lustre_kcompr_30149: compr lz4(4) in 64kB chunks took 32787 us (121 MB/s), compress ratio: 2.67 [ 438.170556] lustre_kcompr_30149: compr lz4(4) in 128kB chunks took 23717 us (168 MB/s), compress ratio: 2.63 [ 438.197734] lustre_kcompr_30149: compr lz4(4) in 256kB chunks took 23173 us (172 MB/s), compress ratio: 2.68 [ 438.222469] lustre_kcompr_30149: compr lz4(4) in 512kB chunks took 20569 us (194 MB/s), compress ratio: 2.71 [ 438.245242] lustre_kcompr_30149: compr lz4(4) in 1024kB chunks took 18988 us (210 MB/s), compress ratio: 2.72 [ 438.270242] lustre_kcompr_30149: compr lz4(4) in 2048kB chunks took 21030 us (190 MB/s), compress ratio: 2.72 [ 438.292439] lustre_kcompr_30149: compr lz4(4) in 4096kB chunks took 18902 us (211 MB/s), compress ratio: 2.73 [ 438.307509] lustre_kcompr_30149: decompr lz4(4) took 4767 us (306 MB/s) [ 438.310683] lustre_kcompr_30149: test_comp_compress_decompress(lz4,4) ret 0 [ 438.314026] lustre_kcompr_30149: acompr lz4(4) of 128kB chunks took 554 us (225 MB/s), compress ratio: 2.30 [ 438.317917] lustre_kcompr_30149: adecompr lz4(4) took 187 us (289 MB/s) [ 438.321881] lustre_kcompr_30149: test_acomp_compress_decompress(lz4,4) ret 0 [ 438.349708] lustre_kcompr_30149: compr lz4(9) in 64kB chunks took 14784 us (270 MB/s), compress ratio: 2.30 [ 438.367603] lustre_kcompr_30149: compr lz4(9) in 128kB chunks took 14660 us (272 MB/s), compress ratio: 2.15 [ 438.386708] lustre_kcompr_30149: compr lz4(9) in 256kB chunks took 15450 us (258 MB/s), compress ratio: 2.20 [ 438.408910] lustre_kcompr_30149: compr lz4(9) in 512kB chunks took 19165 us (208 MB/s), compress ratio: 2.23 [ 438.433764] lustre_kcompr_30149: compr lz4(9) in 1024kB chunks took 21819 us (183 MB/s), compress ratio: 2.25 [ 438.453411] lustre_kcompr_30149: compr lz4(9) in 2048kB chunks took 16132 us (247 MB/s), compress ratio: 2.25 [ 438.471871] lustre_kcompr_30149: compr lz4(9) in 4096kB chunks took 15395 us (259 MB/s), compress ratio: 2.26 [ 438.492720] lustre_kcompr_30149: decompr lz4(9) took 12000 us (147 MB/s) [ 438.495952] lustre_kcompr_30149: test_comp_compress_decompress(lz4,9) ret 0 [ 438.499707] lustre_kcompr_30149: acompr lz4(9) of 128kB chunks took 501 us (249 MB/s), compress ratio: 1.87 [ 438.502976] lustre_kcompr_30149: adecompr lz4(9) took 171 us (389 MB/s) [ 438.507429] lustre_kcompr_30149: test_acomp_compress_decompress(lz4,9) ret 0 [ 438.529913] lustre_kcompr_30149: compr lz4(15) in 64kB chunks took 12628 us (316 MB/s), compress ratio: 1.63 [ 438.548503] lustre_kcompr_30149: compr lz4(15) in 128kB chunks took 15593 us (256 MB/s), compress ratio: 1.52 [ 438.565576] lustre_kcompr_30149: compr lz4(15) in 256kB chunks took 13959 us (286 MB/s), compress ratio: 1.56 [ 438.580161] lustre_kcompr_30149: compr lz4(15) in 512kB chunks took 11537 us (346 MB/s), compress ratio: 1.58 [ 438.593519] lustre_kcompr_30149: compr lz4(15) in 1024kB chunks took 10081 us (396 MB/s), compress ratio: 1.60 [ 438.608841] lustre_kcompr_30149: compr lz4(15) in 2048kB chunks took 12349 us (323 MB/s), compress ratio: 1.60 [ 438.628568] lustre_kcompr_30149: compr lz4(15) in 4096kB chunks took 12083 us (331 MB/s), compress ratio: 1.60 [ 438.641867] lustre_kcompr_30149: decompr lz4(15) took 3090 us (804 MB/s) [ 438.644838] lustre_kcompr_30149: test_comp_compress_decompress(lz4,15) ret 0 [ 438.648269] lustre_kcompr_30149: acompr lz4(15) of 128kB chunks took 444 us (281 MB/s), compress ratio: 1.33 [ 438.651738] lustre_kcompr_30149: adecompr lz4(15) took 158 us (594 MB/s) [ 438.655769] lustre_kcompr_30149: test_acomp_compress_decompress(lz4,15) ret 0 [ 438.764789] lustre_kcompr_30149: compr lz4hc(1) in 64kB chunks took 101310 us (39 MB/s), compress ratio: 3.58 [ 439.035624] lustre_kcompr_30149: compr lz4hc(1) in 128kB chunks took 259609 us (15 MB/s), compress ratio: 3.77 [ 439.266625] lustre_kcompr_30149: compr lz4hc(1) in 256kB chunks took 223301 us (17 MB/s), compress ratio: 3.88 [ 439.362220] lustre_kcompr_30149: compr lz4hc(1) in 512kB chunks took 91949 us (43 MB/s), compress ratio: 3.93 [ 439.485357] lustre_kcompr_30149: compr lz4hc(1) in 1024kB chunks took 119080 us (33 MB/s), compress ratio: 3.96 [ 439.636470] lustre_kcompr_30149: compr lz4hc(1) in 2048kB chunks took 145867 us (27 MB/s), compress ratio: 3.97 [ 439.721193] lustre_kcompr_30149: compr lz4hc(1) in 4096kB chunks took 79807 us (50 MB/s), compress ratio: 3.98 [ 439.731183] lustre_kcompr_30149: decompr lz4hc(1) took 3623 us (277 MB/s) [ 439.733760] lustre_kcompr_30149: test_comp_compress_decompress(lz4hc,1) ret 0 [ 439.740361] lustre_kcompr_30149: acompr lz4hc(1) of 128kB chunks took 3582 us (34 MB/s), compress ratio: 3.27 [ 439.744558] lustre_kcompr_30149: adecompr lz4hc(1) took 312 us (122 MB/s) [ 439.750651] lustre_kcompr_30149: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 439.876947] lustre_kcompr_30149: compr lz4hc(3) in 64kB chunks took 117511 us (34 MB/s), compress ratio: 3.68 [ 440.057929] lustre_kcompr_30149: compr lz4hc(3) in 128kB chunks took 177401 us (22 MB/s), compress ratio: 3.91 [ 440.199232] lustre_kcompr_30149: compr lz4hc(3) in 256kB chunks took 132163 us (30 MB/s), compress ratio: 4.04 [ 440.482837] lustre_kcompr_30149: compr lz4hc(3) in 512kB chunks took 279135 us (14 MB/s), compress ratio: 4.10 [ 440.816947] lustre_kcompr_30149: compr lz4hc(3) in 1024kB chunks took 330118 us (12 MB/s), compress ratio: 4.13 [ 441.346606] lustre_kcompr_30149: compr lz4hc(3) in 2048kB chunks took 517793 us (7 MB/s), compress ratio: 4.15 [ 441.825661] lustre_kcompr_30149: compr lz4hc(3) in 4096kB chunks took 463321 us (8 MB/s), compress ratio: 4.16 [ 441.838991] lustre_kcompr_30149: decompr lz4hc(3) took 4128 us (232 MB/s) [ 441.842754] lustre_kcompr_30149: test_comp_compress_decompress(lz4hc,3) ret 0 [ 441.859608] lustre_kcompr_30149: acompr lz4hc(3) of 128kB chunks took 10906 us (11 MB/s), compress ratio: 3.38 [ 441.865284] lustre_kcompr_30149: adecompr lz4hc(3) took 287 us (128 MB/s) [ 441.868917] lustre_kcompr_30149: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 442.264499] lustre_kcompr_30149: compr lz4hc(8) in 64kB chunks took 383524 us (10 MB/s), compress ratio: 3.72 [ 442.633888] lustre_kcompr_30149: compr lz4hc(8) in 128kB chunks took 358437 us (11 MB/s), compress ratio: 3.96 [ 442.901551] lustre_kcompr_30149: compr lz4hc(8) in 256kB chunks took 262639 us (15 MB/s), compress ratio: 4.10 [ 443.232594] lustre_kcompr_30149: compr lz4hc(8) in 512kB chunks took 327949 us (12 MB/s), compress ratio: 4.17 [ 443.847208] lustre_kcompr_30149: compr lz4hc(8) in 1024kB chunks took 596370 us (6 MB/s), compress ratio: 4.21 [ 444.890190] lustre_kcompr_30149: compr lz4hc(8) in 2048kB chunks took 1036513 us (3 MB/s), compress ratio: 4.22 [ 445.941497] lustre_kcompr_30149: compr lz4hc(8) in 4096kB chunks took 1040840 us (3 MB/s), compress ratio: 4.23 [ 446.007868] lustre_kcompr_30149: decompr lz4hc(8) took 16479 us (57 MB/s) [ 446.013023] lustre_kcompr_30149: test_comp_compress_decompress(lz4hc,8) ret 0 [ 446.063195] lustre_kcompr_30149: acompr lz4hc(8) of 128kB chunks took 41150 us (3 MB/s), compress ratio: 3.42 [ 446.078513] lustre_kcompr_30149: adecompr lz4hc(8) took 232 us (157 MB/s) [ 446.119392] lustre_kcompr_30149: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 446.716401] lustre_kcompr_30149: compr lz4hc(15) in 64kB chunks took 562185 us (7 MB/s), compress ratio: 3.72 [ 447.489641] lustre_kcompr_30149: compr lz4hc(15) in 128kB chunks took 766026 us (5 MB/s), compress ratio: 3.96 [ 448.250337] lustre_kcompr_30149: compr lz4hc(15) in 256kB chunks took 756031 us (5 MB/s), compress ratio: 4.10 [ 449.026277] lustre_kcompr_30149: compr lz4hc(15) in 512kB chunks took 765710 us (5 MB/s), compress ratio: 4.17 [ 449.916630] lustre_kcompr_30149: compr lz4hc(15) in 1024kB chunks took 878419 us (4 MB/s), compress ratio: 4.21 [ 450.561393] lustre_kcompr_30149: compr lz4hc(15) in 2048kB chunks took 600007 us (6 MB/s), compress ratio: 4.22 [ 451.557388] lustre_kcompr_30149: compr lz4hc(15) in 4096kB chunks took 993114 us (4 MB/s), compress ratio: 4.23 [ 451.572450] lustre_kcompr_30149: decompr lz4hc(15) took 5837 us (161 MB/s) [ 451.576618] lustre_kcompr_30149: test_comp_compress_decompress(lz4hc,15) ret 0 [ 451.588989] lustre_kcompr_30149: acompr lz4hc(15) of 128kB chunks took 8036 us (15 MB/s), compress ratio: 3.42 [ 451.593585] lustre_kcompr_30149: adecompr lz4hc(15) took 340 us (107 MB/s) [ 451.600335] lustre_kcompr_30149: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 451.636910] lustre_kcompr_30149: compr lzo(-1) in 64kB chunks took 32511 us (123 MB/s), compress ratio: 2.90 [ 451.679589] lustre_kcompr_30149: compr lzo(-1) in 128kB chunks took 35842 us (111 MB/s), compress ratio: 2.95 [ 451.725719] lustre_kcompr_30149: compr lzo(-1) in 256kB chunks took 37959 us (105 MB/s), compress ratio: 2.96 [ 451.784495] lustre_kcompr_30149: compr lzo(-1) in 512kB chunks took 47399 us (84 MB/s), compress ratio: 2.98 [ 451.830387] lustre_kcompr_30149: compr lzo(-1) in 1024kB chunks took 38613 us (103 MB/s), compress ratio: 2.97 [ 451.873890] lustre_kcompr_30149: compr lzo(-1) in 2048kB chunks took 37179 us (107 MB/s), compress ratio: 2.97 [ 451.907959] lustre_kcompr_30149: compr lzo(-1) in 4096kB chunks took 28050 us (142 MB/s), compress ratio: 2.96 [ 451.961128] lustre_kcompr_30149: decompr lzo(-1) took 22161 us (60 MB/s) [ 451.975578] lustre_kcompr_30149: test_comp_compress_decompress(lzo,-1) ret 0 [ 451.992583] lustre_kcompr_30149: acompr lzo(-1) of 128kB chunks took 950 us (131 MB/s), compress ratio: 2.62 [ 452.000899] lustre_kcompr_30149: adecompr lzo(-1) took 323 us (147 MB/s) [ 452.018597] lustre_kcompr_30149: test_acomp_compress_decompress(lzo,-1) ret 0 [ 452.415515] lustre_kcompr_30149: compr deflate(1) in 64kB chunks took 373244 us (10 MB/s), compress ratio: 3.51 [ 453.065180] lustre_kcompr_30149: compr deflate(1) in 128kB chunks took 645277 us (6 MB/s), compress ratio: 3.53 [ 453.855461] lustre_kcompr_30149: compr deflate(1) in 256kB chunks took 782074 us (5 MB/s), compress ratio: 3.53 [ 454.667135] lustre_kcompr_30149: compr deflate(1) in 512kB chunks took 799432 us (5 MB/s), compress ratio: 3.54 [ 455.327553] lustre_kcompr_30149: compr deflate(1) in 1024kB chunks took 648862 us (6 MB/s), compress ratio: 3.54 [ 456.100281] lustre_kcompr_30149: compr deflate(1) in 2048kB chunks took 766736 us (5 MB/s), compress ratio: 3.54 [ 456.973693] lustre_kcompr_30149: compr deflate(1) in 4096kB chunks took 864081 us (4 MB/s), compress ratio: 3.54 [ 457.126222] lustre_kcompr_30149: decompr deflate(1) took 118300 us (9 MB/s) [ 457.150771] lustre_kcompr_30149: test_comp_compress_decompress(deflate,1) ret 0 [ 457.204643] lustre_kcompr_30149: acompr deflate(1) of 128kB chunks took 26033 us (4 MB/s), compress ratio: 3.09 [ 457.219280] lustre_kcompr_30149: adecompr deflate(1) took 2000 us (20 MB/s) [ 457.226957] lustre_kcompr_30149: test_acomp_compress_decompress(deflate,1) ret 0 [ 458.050465] lustre_kcompr_30149: compr deflate(6) in 64kB chunks took 806619 us (4 MB/s), compress ratio: 3.51 [ 459.166202] lustre_kcompr_30149: compr deflate(6) in 128kB chunks took 1111076 us (3 MB/s), compress ratio: 3.53 [ 459.973804] lustre_kcompr_30149: compr deflate(6) in 256kB chunks took 794450 us (5 MB/s), compress ratio: 3.53 [ 460.820561] lustre_kcompr_30149: compr deflate(6) in 512kB chunks took 834841 us (4 MB/s), compress ratio: 3.54 [ 461.664157] lustre_kcompr_30149: compr deflate(6) in 1024kB chunks took 838654 us (4 MB/s), compress ratio: 3.54 [ 462.270607] lustre_kcompr_30149: compr deflate(6) in 2048kB chunks took 600742 us (6 MB/s), compress ratio: 3.54 [ 462.993765] lustre_kcompr_30149: compr deflate(6) in 4096kB chunks took 707321 us (5 MB/s), compress ratio: 3.54 [ 463.102914] lustre_kcompr_30149: decompr deflate(6) took 88709 us (12 MB/s) [ 463.125896] lustre_kcompr_30149: test_comp_compress_decompress(deflate,6) ret 0 [ 463.167345] lustre_kcompr_30149: acompr deflate(6) of 128kB chunks took 32593 us (3 MB/s), compress ratio: 3.09 [ 463.176943] lustre_kcompr_30149: adecompr deflate(6) took 1039 us (38 MB/s) [ 463.207149] lustre_kcompr_30149: test_acomp_compress_decompress(deflate,6) ret 0 [ 463.951379] lustre_kcompr_30149: compr deflate(9) in 64kB chunks took 725897 us (5 MB/s), compress ratio: 3.51 [ 464.976787] lustre_kcompr_30149: compr deflate(9) in 128kB chunks took 1020087 us (3 MB/s), compress ratio: 3.53 [ 465.946752] lustre_kcompr_30149: compr deflate(9) in 256kB chunks took 947119 us (4 MB/s), compress ratio: 3.53 [ 466.901146] lustre_kcompr_30149: compr deflate(9) in 512kB chunks took 944398 us (4 MB/s), compress ratio: 3.54 [ 467.896327] lustre_kcompr_30149: compr deflate(9) in 1024kB chunks took 980931 us (4 MB/s), compress ratio: 3.54 [ 468.800359] lustre_kcompr_30149: compr deflate(9) in 2048kB chunks took 893543 us (4 MB/s), compress ratio: 3.54 [ 469.474470] lustre_kcompr_30149: compr deflate(9) in 4096kB chunks took 662682 us (6 MB/s), compress ratio: 3.54 [ 469.552475] lustre_kcompr_30149: decompr deflate(9) took 59335 us (19 MB/s) [ 469.558837] lustre_kcompr_30149: test_comp_compress_decompress(deflate,9) ret 0 [ 469.589807] lustre_kcompr_30149: acompr deflate(9) of 128kB chunks took 25653 us (4 MB/s), compress ratio: 3.09 [ 469.597536] lustre_kcompr_30149: adecompr deflate(9) took 1430 us (28 MB/s) [ 469.609877] lustre_kcompr_30149: test_acomp_compress_decompress(deflate,9) ret 0 [ 469.793723] lustre_kcompr_30149: compr zstd(0) in 64kB chunks took 161796 us (24 MB/s), compress ratio: 4.28 [ 470.047866] lustre_kcompr_30149: compr zstd(0) in 128kB chunks took 250057 us (15 MB/s), compress ratio: 4.46 [ 470.262896] lustre_kcompr_30149: compr zstd(0) in 256kB chunks took 200011 us (19 MB/s), compress ratio: 4.61 [ 470.557950] lustre_kcompr_30149: compr zstd(0) in 512kB chunks took 277508 us (14 MB/s), compress ratio: 4.72 [ 470.953297] lustre_kcompr_30149: compr zstd(0) in 1024kB chunks took 385733 us (10 MB/s), compress ratio: 4.80 [ 471.387618] lustre_kcompr_30149: compr zstd(0) in 2048kB chunks took 426151 us (9 MB/s), compress ratio: 4.85 [ 471.803679] lustre_kcompr_30149: compr zstd(0) in 4096kB chunks took 410420 us (9 MB/s), compress ratio: 4.88 [ 471.853794] lustre_kcompr_30149: decompr zstd(0) took 41399 us (19 MB/s) [ 471.858806] lustre_kcompr_30149: test_comp_compress_decompress(zstd,0) ret 0 [ 471.865780] lustre_kcompr_30149: acompr zstd(0) of 128kB chunks took 2938 us (42 MB/s), compress ratio: 3.98 [ 471.871244] lustre_kcompr_30149: adecompr zstd(0) took 643 us (48 MB/s) [ 471.878607] lustre_kcompr_30149: test_acomp_compress_decompress(zstd,0) ret 0 [ 472.024653] lustre_kcompr_30149: compr zstd(1) in 64kB chunks took 123036 us (32 MB/s), compress ratio: 4.06 [ 472.150390] lustre_kcompr_30149: compr zstd(1) in 128kB chunks took 113526 us (35 MB/s), compress ratio: 4.20 [ 472.281927] lustre_kcompr_30149: compr zstd(1) in 256kB chunks took 118451 us (33 MB/s), compress ratio: 4.34 [ 472.400392] lustre_kcompr_30149: compr zstd(1) in 512kB chunks took 98400 us (40 MB/s), compress ratio: 4.34 [ 472.528439] lustre_kcompr_30149: compr zstd(1) in 1024kB chunks took 120012 us (33 MB/s), compress ratio: 4.37 [ 472.683486] lustre_kcompr_30149: compr zstd(1) in 2048kB chunks took 132268 us (30 MB/s), compress ratio: 4.39 [ 472.795834] lustre_kcompr_30149: compr zstd(1) in 4096kB chunks took 106524 us (37 MB/s), compress ratio: 4.40 [ 472.870380] lustre_kcompr_30149: decompr zstd(1) took 49896 us (18 MB/s) [ 472.898955] lustre_kcompr_30149: test_comp_compress_decompress(zstd,1) ret 0 [ 472.904488] lustre_kcompr_30149: acompr zstd(1) of 128kB chunks took 1295 us (96 MB/s), compress ratio: 3.73 [ 472.922373] lustre_kcompr_30149: adecompr zstd(1) took 774 us (43 MB/s) [ 472.937963] lustre_kcompr_30149: test_acomp_compress_decompress(zstd,1) ret 0 [ 474.659355] lustre_kcompr_30149: compr zstd(10) in 64kB chunks took 1702032 us (2 MB/s), compress ratio: 4.80 [ 476.952199] lustre_kcompr_30149: compr zstd(10) in 128kB chunks took 2280940 us (1 MB/s), compress ratio: 5.09 [ 479.448378] lustre_kcompr_30149: compr zstd(10) in 256kB chunks took 2489154 us (1 MB/s), compress ratio: 5.34 [ 481.175330] lustre_kcompr_30149: compr zstd(10) in 512kB chunks took 1718068 us (2 MB/s), compress ratio: 5.45 [ 483.169537] lustre_kcompr_30149: compr zstd(10) in 1024kB chunks took 1971911 us (2 MB/s), compress ratio: 5.62 [ 484.980798] lustre_kcompr_30149: compr zstd(10) in 2048kB chunks took 1800280 us (2 MB/s), compress ratio: 5.76 [ 486.900099] lustre_kcompr_30149: compr zstd(10) in 4096kB chunks took 1915299 us (2 MB/s), compress ratio: 5.89 [ 486.937070] lustre_kcompr_30149: decompr zstd(10) took 25232 us (26 MB/s) [ 486.949259] lustre_kcompr_30149: test_comp_compress_decompress(zstd,10) ret 0 [ 487.037912] lustre_kcompr_30149: acompr zstd(10) of 128kB chunks took 75509 us (1 MB/s), compress ratio: 4.46 [ 487.052130] lustre_kcompr_30149: adecompr zstd(10) took 562 us (49 MB/s) [ 487.070561] lustre_kcompr_30149: test_acomp_compress_decompress(zstd,10) ret 0 [ 506.150938] lustre_kcompr_30149: compr zstd(15) in 64kB chunks took 19044617 us (0 MB/s), compress ratio: 4.96 [ 522.367937] lustre_kcompr_30149: compr zstd(15) in 128kB chunks took 16196289 us (0 MB/s), compress ratio: 5.28 [ 542.069883] lustre_kcompr_30149: compr zstd(15) in 256kB chunks took 19689277 us (0 MB/s), compress ratio: 5.57 [ 554.858419] lustre_kcompr_30149: compr zstd(15) in 512kB chunks took 12772487 us (0 MB/s), compress ratio: 5.83 [ 563.156929] lustre_kcompr_30149: compr zstd(15) in 1024kB chunks took 8292467 us (0 MB/s), compress ratio: 6.06 [ 572.622320] lustre_kcompr_30149: compr zstd(15) in 2048kB chunks took 9462260 us (0 MB/s), compress ratio: 6.26 [ 583.885670] lustre_kcompr_30149: compr zstd(15) in 4096kB chunks took 11260579 us (0 MB/s), compress ratio: 6.46 [ 583.960800] lustre_kcompr_30149: decompr zstd(15) took 47060 us (13 MB/s) [ 583.984050] lustre_kcompr_30149: test_comp_compress_decompress(zstd,15) ret 0 [ 584.790743] lustre_kcompr_30149: acompr zstd(15) of 128kB chunks took 791641 us (0 MB/s), compress ratio: 4.64 [ 584.800127] lustre_kcompr_30149: adecompr zstd(15) took 656 us (41 MB/s) [ 584.874199] lustre_kcompr_30149: test_acomp_compress_decompress(zstd,15) ret 0 [ 585.062539] lustre_kcompr_30149: compr zstdfast(1) in 64kB chunks took 153122 us (26 MB/s), compress ratio: 3.49 [ 585.211818] lustre_kcompr_30149: compr zstdfast(1) in 128kB chunks took 131088 us (30 MB/s), compress ratio: 3.62 [ 585.309464] lustre_kcompr_30149: compr zstdfast(1) in 256kB chunks took 85350 us (46 MB/s), compress ratio: 3.84 [ 585.430595] lustre_kcompr_30149: compr zstdfast(1) in 512kB chunks took 115090 us (34 MB/s), compress ratio: 3.73 [ 585.564464] lustre_kcompr_30149: compr zstdfast(1) in 1024kB chunks took 114488 us (34 MB/s), compress ratio: 3.76 [ 585.643480] lustre_kcompr_30149: compr zstdfast(1) in 2048kB chunks took 61783 us (64 MB/s), compress ratio: 3.77 [ 585.707391] lustre_kcompr_30149: compr zstdfast(1) in 4096kB chunks took 59023 us (67 MB/s), compress ratio: 3.78 [ 585.738308] lustre_kcompr_30149: decompr zstdfast(1) took 16901 us (62 MB/s) [ 585.743683] lustre_kcompr_30149: test_comp_compress_decompress(zstdfast,1) ret 0 [ 585.748848] lustre_kcompr_30149: acompr zstdfast(1) of 128kB chunks took 2283 us (54 MB/s), compress ratio: 3.19 [ 585.754795] lustre_kcompr_30149: adecompr zstdfast(1) took 785 us (49 MB/s) [ 585.769987] lustre_kcompr_30149: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 585.839559] lustre_kcompr_30149: compr zstdfast(5) in 64kB chunks took 53262 us (75 MB/s), compress ratio: 2.81 [ 585.910176] lustre_kcompr_30149: compr zstdfast(5) in 128kB chunks took 63798 us (62 MB/s), compress ratio: 2.93 [ 586.063905] lustre_kcompr_30149: compr zstdfast(5) in 256kB chunks took 143461 us (27 MB/s), compress ratio: 3.16 [ 586.167566] lustre_kcompr_30149: compr zstdfast(5) in 512kB chunks took 92026 us (43 MB/s), compress ratio: 3.04 [ 586.284211] lustre_kcompr_30149: compr zstdfast(5) in 1024kB chunks took 100054 us (39 MB/s), compress ratio: 3.07 [ 586.442659] lustre_kcompr_30149: compr zstdfast(5) in 2048kB chunks took 153228 us (26 MB/s), compress ratio: 3.08 [ 586.514326] lustre_kcompr_30149: compr zstdfast(5) in 4096kB chunks took 58437 us (68 MB/s), compress ratio: 3.09 [ 586.581793] lustre_kcompr_30149: decompr zstdfast(5) took 40531 us (31 MB/s) [ 586.589113] lustre_kcompr_30149: test_comp_compress_decompress(zstdfast,5) ret 0 [ 586.601789] lustre_kcompr_30149: acompr zstdfast(5) of 128kB chunks took 1590 us (78 MB/s), compress ratio: 2.56 [ 586.608680] lustre_kcompr_30149: adecompr zstdfast(5) took 402 us (121 MB/s) [ 586.638169] lustre_kcompr_30149: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 586.712307] lustre_kcompr_30149: compr zstdfast(12) in 64kB chunks took 52175 us (76 MB/s), compress ratio: 1.43 [ 586.781367] lustre_kcompr_30149: compr zstdfast(12) in 128kB chunks took 40128 us (99 MB/s), compress ratio: 1.50 [ 586.826249] lustre_kcompr_30149: compr zstdfast(12) in 256kB chunks took 35447 us (112 MB/s), compress ratio: 1.62 [ 586.876762] lustre_kcompr_30149: compr zstdfast(12) in 512kB chunks took 44771 us (89 MB/s), compress ratio: 1.55 [ 586.962337] lustre_kcompr_30149: compr zstdfast(12) in 1024kB chunks took 65626 us (60 MB/s), compress ratio: 1.58 [ 586.995247] lustre_kcompr_30149: compr zstdfast(12) in 2048kB chunks took 25504 us (156 MB/s), compress ratio: 1.60 [ 587.027271] lustre_kcompr_30149: compr zstdfast(12) in 4096kB chunks took 28386 us (140 MB/s), compress ratio: 1.60 [ 587.050806] lustre_kcompr_30149: decompr zstdfast(12) took 8750 us (284 MB/s) [ 587.057521] lustre_kcompr_30149: test_comp_compress_decompress(zstdfast,12) ret 0 [ 587.063365] lustre_kcompr_30149: acompr zstdfast(12) of 128kB chunks took 649 us (192 MB/s), compress ratio: 1.37 [ 587.070163] lustre_kcompr_30149: adecompr zstdfast(12) took 238 us (383 MB/s) [ 587.078291] lustre_kcompr_30149: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 587.115372] lustre_kcompr_30149: compr zstdfast(15) in 64kB chunks took 19644 us (203 MB/s), compress ratio: 1.12 [ 587.139137] lustre_kcompr_30149: compr zstdfast(15) in 128kB chunks took 16377 us (244 MB/s), compress ratio: 1.16 [ 587.161382] lustre_kcompr_30149: compr zstdfast(15) in 256kB chunks took 15994 us (250 MB/s), compress ratio: 1.22 [ 587.183778] lustre_kcompr_30149: compr zstdfast(15) in 512kB chunks took 16447 us (243 MB/s), compress ratio: 1.20 [ 587.207498] lustre_kcompr_30149: compr zstdfast(15) in 1024kB chunks took 17682 us (226 MB/s), compress ratio: 1.22 [ 587.248606] lustre_kcompr_30149: compr zstdfast(15) in 2048kB chunks took 34823 us (114 MB/s), compress ratio: 1.23 [ 587.304540] lustre_kcompr_30149: compr zstdfast(15) in 4096kB chunks took 39088 us (102 MB/s), compress ratio: 1.23 [ 587.339425] lustre_kcompr_30149: decompr zstdfast(15) took 11743 us (275 MB/s) [ 587.353498] lustre_kcompr_30149: test_comp_compress_decompress(zstdfast,15) ret 0 [ 587.365253] lustre_kcompr_30149: acompr zstdfast(15) of 128kB chunks took 459 us (272 MB/s), compress ratio: 1.08 [ 587.378385] lustre_kcompr_30149: adecompr zstdfast(15) took 207 us (557 MB/s) [ 587.422440] lustre_kcompr_30149: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 587.434293] lustre_kcompr_30149: SUCCESS [ 595.674081] lustre_kcompr_26026: ***** [ 595.675541] lustre_kcompr_26026: (de)compression test on provided file /tmp/f84.sanity [ 595.687638] lustre_kcompr_26026: ***** [ 595.775898] lustre_kcompr_26026: compr lz4(1) in 64kB chunks took 56450 us (70 MB/s), compress ratio: 2.45 [ 595.823071] lustre_kcompr_26026: compr lz4(1) in 128kB chunks took 41653 us (96 MB/s), compress ratio: 2.39 [ 595.883697] lustre_kcompr_26026: compr lz4(1) in 256kB chunks took 42036 us (95 MB/s), compress ratio: 2.39 [ 595.941075] lustre_kcompr_26026: compr lz4(1) in 512kB chunks took 48473 us (82 MB/s), compress ratio: 2.39 [ 596.024374] lustre_kcompr_26026: compr lz4(1) in 1024kB chunks took 56582 us (70 MB/s), compress ratio: 2.39 [ 596.099105] lustre_kcompr_26026: compr lz4(1) in 2048kB chunks took 66911 us (59 MB/s), compress ratio: 2.39 [ 596.176536] lustre_kcompr_26026: compr lz4(1) in 4096kB chunks took 53624 us (74 MB/s), compress ratio: 2.39 [ 596.220514] lustre_kcompr_26026: decompr lz4(1) took 7863 us (212 MB/s) [ 596.226960] lustre_kcompr_26026: test_comp_compress_decompress(lz4,1) ret 0 [ 596.245995] lustre_kcompr_26026: acompr lz4(1) of 128kB chunks took 360 us (347 MB/s), compress ratio: 15.67 [ 596.256992] lustre_kcompr_26026: adecompr lz4(1) took 126 us (63 MB/s) [ 596.270986] lustre_kcompr_26026: test_acomp_compress_decompress(lz4,1) ret 0 [ 596.308256] lustre_kcompr_26026: compr lz4(4) in 64kB chunks took 15317 us (261 MB/s), compress ratio: 2.36 [ 596.343142] lustre_kcompr_26026: compr lz4(4) in 128kB chunks took 24008 us (166 MB/s), compress ratio: 2.35 [ 596.380485] lustre_kcompr_26026: compr lz4(4) in 256kB chunks took 26135 us (153 MB/s), compress ratio: 2.35 [ 596.434474] lustre_kcompr_26026: compr lz4(4) in 512kB chunks took 44005 us (90 MB/s), compress ratio: 2.35 [ 596.470346] lustre_kcompr_26026: compr lz4(4) in 1024kB chunks took 23209 us (172 MB/s), compress ratio: 2.35 [ 596.502581] lustre_kcompr_26026: compr lz4(4) in 2048kB chunks took 25128 us (159 MB/s), compress ratio: 2.35 [ 596.534338] lustre_kcompr_26026: compr lz4(4) in 4096kB chunks took 23428 us (170 MB/s), compress ratio: 2.35 [ 596.555293] lustre_kcompr_26026: decompr lz4(4) took 6616 us (256 MB/s) [ 596.562412] lustre_kcompr_26026: test_comp_compress_decompress(lz4,4) ret 0 [ 596.574382] lustre_kcompr_26026: acompr lz4(4) of 128kB chunks took 614 us (203 MB/s), compress ratio: 15.30 [ 596.591667] lustre_kcompr_26026: adecompr lz4(4) took 1763 us (4 MB/s) [ 596.625683] lustre_kcompr_26026: test_acomp_compress_decompress(lz4,4) ret 0 [ 596.688212] lustre_kcompr_26026: compr lz4(9) in 64kB chunks took 11216 us (356 MB/s), compress ratio: 2.32 [ 596.717357] lustre_kcompr_26026: compr lz4(9) in 128kB chunks took 23098 us (173 MB/s), compress ratio: 2.31 [ 596.750763] lustre_kcompr_26026: compr lz4(9) in 256kB chunks took 13251 us (301 MB/s), compress ratio: 2.31 [ 596.790134] lustre_kcompr_26026: compr lz4(9) in 512kB chunks took 18876 us (211 MB/s), compress ratio: 2.31 [ 596.819608] lustre_kcompr_26026: compr lz4(9) in 1024kB chunks took 21042 us (190 MB/s), compress ratio: 2.31 [ 596.845443] lustre_kcompr_26026: compr lz4(9) in 2048kB chunks took 15297 us (261 MB/s), compress ratio: 2.32 [ 596.873434] lustre_kcompr_26026: compr lz4(9) in 4096kB chunks took 17996 us (222 MB/s), compress ratio: 2.32 [ 596.910512] lustre_kcompr_26026: decompr lz4(9) took 14688 us (117 MB/s) [ 596.921901] lustre_kcompr_26026: test_comp_compress_decompress(lz4,9) ret 0 [ 596.929148] lustre_kcompr_26026: acompr lz4(9) of 128kB chunks took 96 us (1302 MB/s), compress ratio: 14.81 [ 596.938466] lustre_kcompr_26026: adecompr lz4(9) took 113 us (74 MB/s) [ 596.965892] lustre_kcompr_26026: test_acomp_compress_decompress(lz4,9) ret 0 [ 597.028219] lustre_kcompr_26026: compr lz4(15) in 64kB chunks took 13818 us (289 MB/s), compress ratio: 2.23 [ 597.062437] lustre_kcompr_26026: compr lz4(15) in 128kB chunks took 20505 us (195 MB/s), compress ratio: 2.23 [ 597.081435] lustre_kcompr_26026: compr lz4(15) in 256kB chunks took 15197 us (263 MB/s), compress ratio: 2.23 [ 597.109533] lustre_kcompr_26026: compr lz4(15) in 512kB chunks took 15079 us (265 MB/s), compress ratio: 2.23 [ 597.127134] lustre_kcompr_26026: compr lz4(15) in 1024kB chunks took 12178 us (328 MB/s), compress ratio: 2.23 [ 597.153146] lustre_kcompr_26026: compr lz4(15) in 2048kB chunks took 14240 us (280 MB/s), compress ratio: 2.23 [ 597.185616] lustre_kcompr_26026: compr lz4(15) in 4096kB chunks took 22359 us (178 MB/s), compress ratio: 2.23 [ 597.220514] lustre_kcompr_26026: decompr lz4(15) took 9967 us (179 MB/s) [ 597.227643] lustre_kcompr_26026: test_comp_compress_decompress(lz4,15) ret 0 [ 597.241593] lustre_kcompr_26026: acompr lz4(15) of 128kB chunks took 139 us (899 MB/s), compress ratio: 14.18 [ 597.261737] lustre_kcompr_26026: adecompr lz4(15) took 158 us (55 MB/s) [ 597.293408] lustre_kcompr_26026: test_acomp_compress_decompress(lz4,15) ret 0 [ 597.702075] lustre_kcompr_26026: compr lz4hc(1) in 64kB chunks took 359718 us (11 MB/s), compress ratio: 2.54 [ 597.842460] lustre_kcompr_26026: compr lz4hc(1) in 128kB chunks took 125231 us (31 MB/s), compress ratio: 2.61 [ 598.218120] lustre_kcompr_26026: compr lz4hc(1) in 256kB chunks took 371322 us (10 MB/s), compress ratio: 2.64 [ 598.554573] lustre_kcompr_26026: compr lz4hc(1) in 512kB chunks took 320447 us (12 MB/s), compress ratio: 2.66 [ 598.915628] lustre_kcompr_26026: compr lz4hc(1) in 1024kB chunks took 351019 us (11 MB/s), compress ratio: 2.67 [ 599.492375] lustre_kcompr_26026: compr lz4hc(1) in 2048kB chunks took 563788 us (7 MB/s), compress ratio: 2.67 [ 600.084135] lustre_kcompr_26026: compr lz4hc(1) in 4096kB chunks took 574095 us (6 MB/s), compress ratio: 2.67 [ 600.134143] lustre_kcompr_26026: decompr lz4hc(1) took 12175 us (122 MB/s) [ 600.143742] lustre_kcompr_26026: test_comp_compress_decompress(lz4hc,1) ret 0 [ 600.165579] lustre_kcompr_26026: acompr lz4hc(1) of 128kB chunks took 8102 us (15 MB/s), compress ratio: 15.97 [ 600.188838] lustre_kcompr_26026: adecompr lz4hc(1) took 1159 us (6 MB/s) [ 600.198832] lustre_kcompr_26026: test_acomp_compress_decompress(lz4hc,1) ret 0 [ 600.675304] lustre_kcompr_26026: compr lz4hc(3) in 64kB chunks took 430251 us (9 MB/s), compress ratio: 2.57 [ 601.112837] lustre_kcompr_26026: compr lz4hc(3) in 128kB chunks took 431244 us (9 MB/s), compress ratio: 2.64 [ 601.561038] lustre_kcompr_26026: compr lz4hc(3) in 256kB chunks took 430524 us (9 MB/s), compress ratio: 2.68 [ 602.023695] lustre_kcompr_26026: compr lz4hc(3) in 512kB chunks took 449656 us (8 MB/s), compress ratio: 2.69 [ 602.664158] lustre_kcompr_26026: compr lz4hc(3) in 1024kB chunks took 634801 us (6 MB/s), compress ratio: 2.70 [ 603.315555] lustre_kcompr_26026: compr lz4hc(3) in 2048kB chunks took 632502 us (6 MB/s), compress ratio: 2.71 [ 603.793543] lustre_kcompr_26026: compr lz4hc(3) in 4096kB chunks took 471074 us (8 MB/s), compress ratio: 2.71 [ 603.834176] lustre_kcompr_26026: decompr lz4hc(3) took 17517 us (84 MB/s) [ 603.847600] lustre_kcompr_26026: test_comp_compress_decompress(lz4hc,3) ret 0 [ 603.867529] lustre_kcompr_26026: acompr lz4hc(3) of 128kB chunks took 4160 us (30 MB/s), compress ratio: 16.00 [ 603.884195] lustre_kcompr_26026: adecompr lz4hc(3) took 2547 us (3 MB/s) [ 603.914871] lustre_kcompr_26026: test_acomp_compress_decompress(lz4hc,3) ret 0 [ 604.688602] lustre_kcompr_26026: compr lz4hc(8) in 64kB chunks took 733391 us (5 MB/s), compress ratio: 2.60 [ 605.612199] lustre_kcompr_26026: compr lz4hc(8) in 128kB chunks took 902442 us (4 MB/s), compress ratio: 2.66 [ 606.531936] lustre_kcompr_26026: compr lz4hc(8) in 256kB chunks took 910891 us (4 MB/s), compress ratio: 2.70 [ 607.516365] lustre_kcompr_26026: compr lz4hc(8) in 512kB chunks took 978116 us (4 MB/s), compress ratio: 2.71 [ 608.714654] lustre_kcompr_26026: compr lz4hc(8) in 1024kB chunks took 1187755 us (3 MB/s), compress ratio: 2.72 [ 610.541554] lustre_kcompr_26026: compr lz4hc(8) in 2048kB chunks took 1813337 us (2 MB/s), compress ratio: 2.73 [ 612.143811] lustre_kcompr_26026: compr lz4hc(8) in 4096kB chunks took 1595397 us (2 MB/s), compress ratio: 2.73 [ 612.171347] lustre_kcompr_26026: decompr lz4hc(8) took 8898 us (164 MB/s) [ 612.176903] lustre_kcompr_26026: test_comp_compress_decompress(lz4hc,8) ret 0 [ 612.203831] lustre_kcompr_26026: acompr lz4hc(8) of 128kB chunks took 15533 us (8 MB/s), compress ratio: 16.17 [ 612.223679] lustre_kcompr_26026: adecompr lz4hc(8) took 214 us (36 MB/s) [ 612.248356] lustre_kcompr_26026: test_acomp_compress_decompress(lz4hc,8) ret 0 [ 619.419901] lustre_kcompr_26026: compr lz4hc(15) in 64kB chunks took 7108205 us (0 MB/s), compress ratio: 2.61 [ 627.700777] lustre_kcompr_26026: compr lz4hc(15) in 128kB chunks took 8276048 us (0 MB/s), compress ratio: 2.67 [ 639.859833] lustre_kcompr_26026: compr lz4hc(15) in 256kB chunks took 12137737 us (0 MB/s), compress ratio: 2.71 [ 657.289890] lustre_kcompr_26026: compr lz4hc(15) in 512kB chunks took 17422795 us (0 MB/s), compress ratio: 2.72 [ 674.896165] lustre_kcompr_26026: compr lz4hc(15) in 1024kB chunks took 17595905 us (0 MB/s), compress ratio: 2.73 [ 686.706324] lustre_kcompr_26026: compr lz4hc(15) in 2048kB chunks took 11793845 us (0 MB/s), compress ratio: 2.74 [ 704.493832] lustre_kcompr_26026: compr lz4hc(15) in 4096kB chunks took 17779125 us (0 MB/s), compress ratio: 2.74 [ 704.512399] lustre_kcompr_26026: decompr lz4hc(15) took 5745 us (253 MB/s) [ 704.522836] lustre_kcompr_26026: test_comp_compress_decompress(lz4hc,15) ret 0 [ 704.587554] lustre_kcompr_26026: acompr lz4hc(15) of 128kB chunks took 56576 us (2 MB/s), compress ratio: 16.30 [ 704.609236] lustre_kcompr_26026: adecompr lz4hc(15) took 1818 us (4 MB/s) [ 704.643153] lustre_kcompr_26026: test_acomp_compress_decompress(lz4hc,15) ret 0 [ 704.674761] lustre_kcompr_26026: compr lzo(-1) in 64kB chunks took 24392 us (163 MB/s), compress ratio: 2.35 [ 704.713569] lustre_kcompr_26026: compr lzo(-1) in 128kB chunks took 30390 us (131 MB/s), compress ratio: 2.35 [ 704.763734] lustre_kcompr_26026: compr lzo(-1) in 256kB chunks took 39153 us (102 MB/s), compress ratio: 2.35 [ 704.816579] lustre_kcompr_26026: compr lzo(-1) in 512kB chunks took 38768 us (103 MB/s), compress ratio: 2.36 [ 704.865198] lustre_kcompr_26026: compr lzo(-1) in 1024kB chunks took 37322 us (107 MB/s), compress ratio: 2.36 [ 704.898536] lustre_kcompr_26026: compr lzo(-1) in 2048kB chunks took 25885 us (154 MB/s), compress ratio: 2.36 [ 704.965502] lustre_kcompr_26026: compr lzo(-1) in 4096kB chunks took 56195 us (71 MB/s), compress ratio: 2.36 [ 705.023338] lustre_kcompr_26026: decompr lzo(-1) took 23423 us (72 MB/s) [ 705.036173] lustre_kcompr_26026: test_comp_compress_decompress(lzo,-1) ret 0 [ 705.051367] lustre_kcompr_26026: acompr lzo(-1) of 128kB chunks took 241 us (518 MB/s), compress ratio: 15.45 [ 705.057361] lustre_kcompr_26026: adecompr lzo(-1) took 489 us (16 MB/s) [ 705.063407] lustre_kcompr_26026: test_acomp_compress_decompress(lzo,-1) ret 0 [ 705.821826] lustre_kcompr_26026: compr deflate(1) in 64kB chunks took 744647 us (5 MB/s), compress ratio: 3.27 [ 706.745328] lustre_kcompr_26026: compr deflate(1) in 128kB chunks took 904078 us (4 MB/s), compress ratio: 3.28 [ 707.746507] lustre_kcompr_26026: compr deflate(1) in 256kB chunks took 976816 us (4 MB/s), compress ratio: 3.28 [ 708.704292] lustre_kcompr_26026: compr deflate(1) in 512kB chunks took 946553 us (4 MB/s), compress ratio: 3.28 [ 709.666606] lustre_kcompr_26026: compr deflate(1) in 1024kB chunks took 956340 us (4 MB/s), compress ratio: 3.28 [ 710.697674] lustre_kcompr_26026: compr deflate(1) in 2048kB chunks took 1020955 us (3 MB/s), compress ratio: 3.28 [ 711.554310] lustre_kcompr_26026: compr deflate(1) in 4096kB chunks took 849394 us (4 MB/s), compress ratio: 3.28 [ 711.646056] lustre_kcompr_26026: decompr deflate(1) took 59163 us (20 MB/s) [ 711.671340] lustre_kcompr_26026: test_comp_compress_decompress(deflate,1) ret 0 [ 711.708305] lustre_kcompr_26026: acompr deflate(1) of 128kB chunks took 24113 us (5 MB/s), compress ratio: 21.43 [ 711.734184] lustre_kcompr_26026: adecompr deflate(1) took 316 us (18 MB/s) [ 711.765629] lustre_kcompr_26026: test_acomp_compress_decompress(deflate,1) ret 0 [ 712.665582] lustre_kcompr_26026: compr deflate(6) in 64kB chunks took 857174 us (4 MB/s), compress ratio: 3.27 [ 713.595827] lustre_kcompr_26026: compr deflate(6) in 128kB chunks took 907659 us (4 MB/s), compress ratio: 3.28 [ 714.614752] lustre_kcompr_26026: compr deflate(6) in 256kB chunks took 1008066 us (3 MB/s), compress ratio: 3.28 [ 715.340087] lustre_kcompr_26026: compr deflate(6) in 512kB chunks took 717716 us (5 MB/s), compress ratio: 3.28 [ 716.342330] lustre_kcompr_26026: compr deflate(6) in 1024kB chunks took 991053 us (4 MB/s), compress ratio: 3.28 [ 717.174548] lustre_kcompr_26026: compr deflate(6) in 2048kB chunks took 795576 us (5 MB/s), compress ratio: 3.28 [ 717.944697] lustre_kcompr_26026: compr deflate(6) in 4096kB chunks took 761430 us (5 MB/s), compress ratio: 3.28 [ 718.046797] lustre_kcompr_26026: decompr deflate(6) took 79481 us (15 MB/s) [ 718.068773] lustre_kcompr_26026: test_comp_compress_decompress(deflate,6) ret 0 [ 718.099379] lustre_kcompr_26026: acompr deflate(6) of 128kB chunks took 20718 us (6 MB/s), compress ratio: 21.43 [ 718.108630] lustre_kcompr_26026: adecompr deflate(6) took 354 us (16 MB/s) [ 718.135532] lustre_kcompr_26026: test_acomp_compress_decompress(deflate,6) ret 0 [ 718.911527] lustre_kcompr_26026: compr deflate(9) in 64kB chunks took 746467 us (5 MB/s), compress ratio: 3.27 [ 719.897454] lustre_kcompr_26026: compr deflate(9) in 128kB chunks took 974940 us (4 MB/s), compress ratio: 3.28 [ 720.939441] lustre_kcompr_26026: compr deflate(9) in 256kB chunks took 1029906 us (3 MB/s), compress ratio: 3.28 [ 721.722603] lustre_kcompr_26026: compr deflate(9) in 512kB chunks took 762582 us (5 MB/s), compress ratio: 3.28 [ 722.381723] lustre_kcompr_26026: compr deflate(9) in 1024kB chunks took 645525 us (6 MB/s), compress ratio: 3.28 [ 723.313912] lustre_kcompr_26026: compr deflate(9) in 2048kB chunks took 924017 us (4 MB/s), compress ratio: 3.28 [ 724.343259] lustre_kcompr_26026: compr deflate(9) in 4096kB chunks took 1008291 us (3 MB/s), compress ratio: 3.28 [ 724.438211] lustre_kcompr_26026: decompr deflate(9) took 59203 us (20 MB/s) [ 724.450599] lustre_kcompr_26026: test_comp_compress_decompress(deflate,9) ret 0 [ 724.497361] lustre_kcompr_26026: acompr deflate(9) of 128kB chunks took 35843 us (3 MB/s), compress ratio: 21.43 [ 724.507342] lustre_kcompr_26026: adecompr deflate(9) took 1152 us (5 MB/s) [ 724.537304] lustre_kcompr_26026: test_acomp_compress_decompress(deflate,9) ret 0 [ 724.692321] lustre_kcompr_26026: compr zstd(0) in 64kB chunks took 130761 us (30 MB/s), compress ratio: 3.28 [ 724.842683] lustre_kcompr_26026: compr zstd(0) in 128kB chunks took 142285 us (28 MB/s), compress ratio: 3.26 [ 725.031338] lustre_kcompr_26026: compr zstd(0) in 256kB chunks took 181704 us (22 MB/s), compress ratio: 3.31 [ 725.313416] lustre_kcompr_26026: compr zstd(0) in 512kB chunks took 273621 us (14 MB/s), compress ratio: 3.32 [ 725.720493] lustre_kcompr_26026: compr zstd(0) in 1024kB chunks took 396537 us (10 MB/s), compress ratio: 3.32 [ 726.150451] lustre_kcompr_26026: compr zstd(0) in 2048kB chunks took 413978 us (9 MB/s), compress ratio: 3.33 [ 726.595202] lustre_kcompr_26026: compr zstd(0) in 4096kB chunks took 427970 us (9 MB/s), compress ratio: 3.33 [ 726.657370] lustre_kcompr_26026: decompr zstd(0) took 43254 us (27 MB/s) [ 726.669867] lustre_kcompr_26026: test_comp_compress_decompress(zstd,0) ret 0 [ 726.679973] lustre_kcompr_26026: acompr zstd(0) of 128kB chunks took 2436 us (51 MB/s), compress ratio: 22.64 [ 726.689532] lustre_kcompr_26026: adecompr zstd(0) took 177 us (31 MB/s) [ 726.710492] lustre_kcompr_26026: test_acomp_compress_decompress(zstd,0) ret 0 [ 726.805591] lustre_kcompr_26026: compr zstd(1) in 64kB chunks took 74653 us (53 MB/s), compress ratio: 3.22 [ 726.874965] lustre_kcompr_26026: compr zstd(1) in 128kB chunks took 62890 us (63 MB/s), compress ratio: 3.18 [ 726.932300] lustre_kcompr_26026: compr zstd(1) in 256kB chunks took 49288 us (81 MB/s), compress ratio: 3.19 [ 727.019308] lustre_kcompr_26026: compr zstd(1) in 512kB chunks took 80357 us (49 MB/s), compress ratio: 3.19 [ 727.118836] lustre_kcompr_26026: compr zstd(1) in 1024kB chunks took 80045 us (49 MB/s), compress ratio: 3.19 [ 727.209637] lustre_kcompr_26026: compr zstd(1) in 2048kB chunks took 86073 us (46 MB/s), compress ratio: 3.19 [ 727.293165] lustre_kcompr_26026: compr zstd(1) in 4096kB chunks took 76373 us (52 MB/s), compress ratio: 3.19 [ 727.343904] lustre_kcompr_26026: decompr zstd(1) took 35707 us (35 MB/s) [ 727.353290] lustre_kcompr_26026: test_comp_compress_decompress(zstd,1) ret 0 [ 727.359090] lustre_kcompr_26026: acompr zstd(1) of 128kB chunks took 559 us (223 MB/s), compress ratio: 22.79 [ 727.370341] lustre_kcompr_26026: adecompr zstd(1) took 269 us (20 MB/s) [ 727.389967] lustre_kcompr_26026: test_acomp_compress_decompress(zstd,1) ret 0 [ 728.644840] lustre_kcompr_26026: compr zstd(10) in 64kB chunks took 1219940 us (3 MB/s), compress ratio: 3.33 [ 729.770330] lustre_kcompr_26026: compr zstd(10) in 128kB chunks took 1119741 us (3 MB/s), compress ratio: 3.33 [ 731.189594] lustre_kcompr_26026: compr zstd(10) in 256kB chunks took 1412698 us (2 MB/s), compress ratio: 3.37 [ 732.474781] lustre_kcompr_26026: compr zstd(10) in 512kB chunks took 1280633 us (3 MB/s), compress ratio: 3.40 [ 733.620293] lustre_kcompr_26026: compr zstd(10) in 1024kB chunks took 1138829 us (3 MB/s), compress ratio: 3.42 [ 734.985277] lustre_kcompr_26026: compr zstd(10) in 2048kB chunks took 1359857 us (2 MB/s), compress ratio: 3.46 [ 736.286748] lustre_kcompr_26026: compr zstd(10) in 4096kB chunks took 1290803 us (3 MB/s), compress ratio: 3.50 [ 736.340296] lustre_kcompr_26026: decompr zstd(10) took 41209 us (27 MB/s) [ 736.350665] lustre_kcompr_26026: test_comp_compress_decompress(zstd,10) ret 0 [ 736.360319] lustre_kcompr_26026: acompr zstd(10) of 128kB chunks took 4498 us (27 MB/s), compress ratio: 22.78 [ 736.367763] lustre_kcompr_26026: adecompr zstd(10) took 474 us (11 MB/s) [ 736.374933] lustre_kcompr_26026: test_acomp_compress_decompress(zstd,10) ret 0 [ 745.651476] lustre_kcompr_26026: compr zstd(15) in 64kB chunks took 9256066 us (0 MB/s), compress ratio: 3.36 [ 756.894600] lustre_kcompr_26026: compr zstd(15) in 128kB chunks took 11229021 us (0 MB/s), compress ratio: 3.39 [ 765.347850] lustre_kcompr_26026: compr zstd(15) in 256kB chunks took 8445553 us (0 MB/s), compress ratio: 3.40 [ 772.580865] lustre_kcompr_26026: compr zstd(15) in 512kB chunks took 7220538 us (0 MB/s), compress ratio: 3.42 [ 780.055023] lustre_kcompr_26026: compr zstd(15) in 1024kB chunks took 7469034 us (0 MB/s), compress ratio: 3.43 [ 786.970491] lustre_kcompr_26026: compr zstd(15) in 2048kB chunks took 6907984 us (0 MB/s), compress ratio: 3.48 [ 793.992481] lustre_kcompr_26026: compr zstd(15) in 4096kB chunks took 7010614 us (0 MB/s), compress ratio: 3.56 [ 794.113811] lustre_kcompr_26026: decompr zstd(15) took 92476 us (12 MB/s) [ 794.126343] lustre_kcompr_26026: test_comp_compress_decompress(zstd,15) ret 0 [ 794.245452] lustre_kcompr_26026: acompr zstd(15) of 128kB chunks took 107732 us (1 MB/s), compress ratio: 23.92 [ 794.263529] lustre_kcompr_26026: adecompr zstd(15) took 213 us (24 MB/s) [ 794.294227] lustre_kcompr_26026: test_acomp_compress_decompress(zstd,15) ret 0 [ 794.381747] lustre_kcompr_26026: compr zstdfast(1) in 64kB chunks took 64970 us (61 MB/s), compress ratio: 2.47 [ 794.470613] lustre_kcompr_26026: compr zstdfast(1) in 128kB chunks took 73764 us (54 MB/s), compress ratio: 2.48 [ 794.556477] lustre_kcompr_26026: compr zstdfast(1) in 256kB chunks took 70935 us (56 MB/s), compress ratio: 2.53 [ 794.628775] lustre_kcompr_26026: compr zstdfast(1) in 512kB chunks took 61216 us (65 MB/s), compress ratio: 2.42 [ 794.678756] lustre_kcompr_26026: compr zstdfast(1) in 1024kB chunks took 40698 us (98 MB/s), compress ratio: 2.42 [ 794.738997] lustre_kcompr_26026: compr zstdfast(1) in 2048kB chunks took 50242 us (79 MB/s), compress ratio: 2.42 [ 794.785486] lustre_kcompr_26026: compr zstdfast(1) in 4096kB chunks took 41185 us (97 MB/s), compress ratio: 2.42 [ 794.806873] lustre_kcompr_26026: decompr zstdfast(1) took 6253 us (263 MB/s) [ 794.813899] lustre_kcompr_26026: test_comp_compress_decompress(zstdfast,1) ret 0 [ 794.823067] lustre_kcompr_26026: acompr zstdfast(1) of 128kB chunks took 714 us (175 MB/s), compress ratio: 17.28 [ 794.829400] lustre_kcompr_26026: adecompr zstdfast(1) took 373 us (19 MB/s) [ 794.837830] lustre_kcompr_26026: test_acomp_compress_decompress(zstdfast,1) ret 0 [ 794.890899] lustre_kcompr_26026: compr zstdfast(5) in 64kB chunks took 34610 us (115 MB/s), compress ratio: 2.38 [ 794.935334] lustre_kcompr_26026: compr zstdfast(5) in 128kB chunks took 30995 us (129 MB/s), compress ratio: 2.38 [ 794.997689] lustre_kcompr_26026: compr zstdfast(5) in 256kB chunks took 52867 us (75 MB/s), compress ratio: 2.40 [ 795.062710] lustre_kcompr_26026: compr zstdfast(5) in 512kB chunks took 46849 us (85 MB/s), compress ratio: 2.36 [ 795.110853] lustre_kcompr_26026: compr zstdfast(5) in 1024kB chunks took 38568 us (103 MB/s), compress ratio: 2.36 [ 795.161514] lustre_kcompr_26026: compr zstdfast(5) in 2048kB chunks took 33276 us (120 MB/s), compress ratio: 2.36 [ 795.223523] lustre_kcompr_26026: compr zstdfast(5) in 4096kB chunks took 52972 us (75 MB/s), compress ratio: 2.36 [ 795.272650] lustre_kcompr_26026: decompr zstdfast(5) took 19048 us (88 MB/s) [ 795.282569] lustre_kcompr_26026: test_comp_compress_decompress(zstdfast,5) ret 0 [ 795.295822] lustre_kcompr_26026: acompr zstdfast(5) of 128kB chunks took 941 us (132 MB/s), compress ratio: 16.12 [ 795.304612] lustre_kcompr_26026: adecompr zstdfast(5) took 216 us (35 MB/s) [ 795.321456] lustre_kcompr_26026: test_acomp_compress_decompress(zstdfast,5) ret 0 [ 795.365682] lustre_kcompr_26026: compr zstdfast(12) in 64kB chunks took 13162 us (303 MB/s), compress ratio: 2.07 [ 795.399329] lustre_kcompr_26026: compr zstdfast(12) in 128kB chunks took 16524 us (242 MB/s), compress ratio: 2.07 [ 795.430455] lustre_kcompr_26026: compr zstdfast(12) in 256kB chunks took 20379 us (196 MB/s), compress ratio: 2.08 [ 795.447900] lustre_kcompr_26026: compr zstdfast(12) in 512kB chunks took 9082 us (440 MB/s), compress ratio: 2.07 [ 795.472765] lustre_kcompr_26026: compr zstdfast(12) in 1024kB chunks took 12153 us (329 MB/s), compress ratio: 2.07 [ 795.498370] lustre_kcompr_26026: compr zstdfast(12) in 2048kB chunks took 9732 us (411 MB/s), compress ratio: 2.07 [ 795.517517] lustre_kcompr_26026: compr zstdfast(12) in 4096kB chunks took 14025 us (285 MB/s), compress ratio: 2.08 [ 795.540777] lustre_kcompr_26026: decompr zstdfast(12) took 4793 us (401 MB/s) [ 795.548569] lustre_kcompr_26026: test_comp_compress_decompress(zstdfast,12) ret 0 [ 795.553200] lustre_kcompr_26026: acompr zstdfast(12) of 128kB chunks took 399 us (313 MB/s), compress ratio: 13.13 [ 795.558164] lustre_kcompr_26026: adecompr zstdfast(12) took 142 us (67 MB/s) [ 795.563883] lustre_kcompr_26026: test_acomp_compress_decompress(zstdfast,12) ret 0 [ 795.577665] lustre_kcompr_26026: compr zstdfast(15) in 64kB chunks took 4958 us (806 MB/s), compress ratio: 1.82 [ 795.585623] lustre_kcompr_26026: compr zstdfast(15) in 128kB chunks took 4264 us (938 MB/s), compress ratio: 1.83 [ 795.594642] lustre_kcompr_26026: compr zstdfast(15) in 256kB chunks took 4916 us (813 MB/s), compress ratio: 1.83 [ 795.622801] lustre_kcompr_26026: compr zstdfast(15) in 512kB chunks took 20093 us (199 MB/s), compress ratio: 1.83 [ 795.643107] lustre_kcompr_26026: compr zstdfast(15) in 1024kB chunks took 8208 us (487 MB/s), compress ratio: 1.83 [ 795.653053] lustre_kcompr_26026: compr zstdfast(15) in 2048kB chunks took 5716 us (699 MB/s), compress ratio: 1.83 [ 795.662756] lustre_kcompr_26026: compr zstdfast(15) in 4096kB chunks took 5526 us (723 MB/s), compress ratio: 1.84 [ 795.676371] lustre_kcompr_26026: decompr zstdfast(15) took 2973 us (730 MB/s) [ 795.680559] lustre_kcompr_26026: test_comp_compress_decompress(zstdfast,15) ret 0 [ 795.685584] lustre_kcompr_26026: acompr zstdfast(15) of 128kB chunks took 207 us (603 MB/s), compress ratio: 10.73 [ 795.690652] lustre_kcompr_26026: adecompr zstdfast(15) took 139 us (83 MB/s) [ 795.696502] lustre_kcompr_26026: test_acomp_compress_decompress(zstdfast,15) ret 0 [ 795.699869] lustre_kcompr_26026: SUCCESS [ 819.430828] Lustre: DEBUG MARKER: == sanity test complete, duration 522 sec ================ 12:39:56 (1789058396) [ 821.691943] Lustre: DEBUG MARKER: === sanity: start cleanup 12:39:58 (1789058398) === [ 825.719451] Lustre: DEBUG MARKER: === sanity: finish cleanup 12:40:02 (1789058402) === [ 828.244128] LustreError: 14317:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8a445153f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 828.314615] Lustre: Unmounted lustre-client [ 871.157794] Key type lgssc unregistered [ 871.398686] LNet: 14855:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 871.407539] LNetError: 14855:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 872.430740] LNet: Removed LNI 192.168.202.40@tcp [ 873.626457] Key type .llcrypt unregistered [ 873.632420] Key type ._llcrypt unregistered