[ 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 531873461 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.002232] x2apic enabled [ 0.003004] Switched APIC routing to physical x2apic. [ 0.004007] kvm-guest: setup PV IPIs [ 0.006261] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007018] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008007] pid_max: default: 32768 minimum: 301 [ 0.009100] LSM: Security Framework initializing [ 0.010027] Yama: becoming mindful. [ 0.011021] SELinux: Initializing. [ 0.011726] *** VALIDATE selinux *** [ 0.018564] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.022254] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.023113] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.024073] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.025080] *** VALIDATE tmpfs *** [ 0.026341] *** VALIDATE proc *** [ 0.027107] *** VALIDATE cgroup *** [ 0.027804] *** VALIDATE cgroup2 *** [ 0.028182] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.029099] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.030004] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.031018] Spectre V2 : User space: Vulnerable [ 0.031880] Speculative Store Bypass: Vulnerable [ 0.034176] debug: unmapping init [mem 0xffffffffa6459000-0xffffffffa6460fff] [ 0.036131] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.037473] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.038014] ... version: 2 [ 0.039011] ... bit width: 48 [ 0.040011] ... generic registers: 4 [ 0.041012] ... value mask: 0000ffffffffffff [ 0.042015] ... max period: 00007fffffffffff [ 0.043016] ... fixed-purpose events: 3 [ 0.044012] ... event mask: 000000070000000f [ 0.045311] rcu: Hierarchical SRCU implementation. [ 0.047392] smp: Bringing up secondary CPUs ... [ 0.048570] x86: Booting SMP configuration: [ 0.049023] .... node #0, CPUs: #1 #2 #3 [ 0.056711] smp: Brought up 1 node, 4 CPUs [ 0.057901] smpboot: Max logical packages: 1 [ 0.058010] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.080678] node 0 deferred pages initialised in 20ms [ 0.083159] devtmpfs: initialized [ 0.084171] x86/mm: Memory block size: 128MB [ 0.086686] gcov: version magic: 0x41383552 [ 0.089348] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.090105] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.091284] pinctrl core: initialized pinctrl subsystem [ 0.092265] [ 0.092871] ************************************************************* [ 0.093018] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.094013] ** ** [ 0.095011] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.096014] ** ** [ 0.097013] ** This means that this kernel is built to expose internal ** [ 0.098014] ** IOMMU data structures, which may compromise security on ** [ 0.099013] ** your system. ** [ 0.100013] ** ** [ 0.101011] ** If you see this message and you are not debugging the ** [ 0.102011] ** kernel, report this immediately to your vendor! ** [ 0.103011] ** ** [ 0.104012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.105013] ************************************************************* [ 0.106675] NET: Registered protocol family 16 [ 0.107428] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.108054] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.109057] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.110452] cpuidle: using governor menu [ 0.111000] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.114380] PCI: Using configuration type 1 for base access [ 0.116118] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.123119] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.124017] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.125175] cryptd: max_cpu_qlen set to 1000 [ 0.127277] ACPI: Added _OSI(Module Device) [ 0.128000] ACPI: Added _OSI(Processor Device) [ 0.128000] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.129009] ACPI: Added _OSI(Processor Aggregator Device) [ 0.132405] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.137641] ACPI: Interpreter enabled [ 0.139038] ACPI: PM: (supports S0 S3 S4 S5) [ 0.140007] ACPI: Using IOAPIC for interrupt routing [ 0.141069] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.143327] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.151652] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.153027] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.154013] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.157066] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.161270] acpiphp: Slot [2] registered [ 0.163132] acpiphp: Slot [5] registered [ 0.164117] acpiphp: Slot [6] registered [ 0.165095] acpiphp: Slot [3] registered [ 0.167083] acpiphp: Slot [4] registered [ 0.168082] acpiphp: Slot [7] registered [ 0.170091] acpiphp: Slot [8] registered [ 0.171099] acpiphp: Slot [9] registered [ 0.173120] acpiphp: Slot [10] registered [ 0.174133] acpiphp: Slot [11] registered [ 0.176088] acpiphp: Slot [12] registered [ 0.177087] acpiphp: Slot [13] registered [ 0.179093] acpiphp: Slot [14] registered [ 0.180087] acpiphp: Slot [15] registered [ 0.182101] acpiphp: Slot [16] registered [ 0.184083] acpiphp: Slot [17] registered [ 0.185085] acpiphp: Slot [18] registered [ 0.187085] acpiphp: Slot [19] registered [ 0.188104] acpiphp: Slot [20] registered [ 0.190071] acpiphp: Slot [21] registered [ 0.191091] acpiphp: Slot [22] registered [ 0.193114] acpiphp: Slot [23] registered [ 0.194171] acpiphp: Slot [24] registered [ 0.195085] acpiphp: Slot [25] registered [ 0.197071] acpiphp: Slot [26] registered [ 0.198062] acpiphp: Slot [27] registered [ 0.199132] acpiphp: Slot [28] registered [ 0.200065] acpiphp: Slot [29] registered [ 0.202091] acpiphp: Slot [30] registered [ 0.203053] acpiphp: Slot [31] registered [ 0.204061] PCI host bridge to bus 0000:00 [ 0.205011] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.208020] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.210019] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.212020] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.215022] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.218023] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.220192] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.223193] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.227380] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.235013] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.239375] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.243018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.245018] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.248020] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.251625] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.254982] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.258051] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.262070] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.268014] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.280014] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.286013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.291712] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.301019] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.311017] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.327017] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.344594] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.355017] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.364015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.382015] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.392283] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.394328] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.395420] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.397268] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.399131] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.404056] iommu: Default domain type: Passthrough [ 0.406435] SCSI subsystem initialized [ 0.407000] ACPI: bus type USB registered [ 0.408114] usbcore: registered new interface driver usbfs [ 0.410085] usbcore: registered new interface driver hub [ 0.412094] usbcore: registered new device driver usb [ 0.415193] pps_core: LinuxPPS API ver. 1 registered [ 0.417011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.420063] PTP clock support registered [ 0.423049] EDAC MC: Ver: 3.0.0 [ 0.424070] PCI: Using ACPI for IRQ routing [ 0.425834] NetLabel: Initializing [ 0.427007] NetLabel: domain hash size = 128 [ 0.428009] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.431092] NetLabel: unlabeled traffic allowed by default [ 0.434114] vgaarb: loaded [ 0.436535] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.438013] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.445000] clocksource: Switched to clocksource kvm-clock [ 0.557074] VFS: Disk quotas dquot_6.6.0 [ 0.558734] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.561379] *** VALIDATE ramfs *** [ 0.562685] *** VALIDATE hugetlbfs *** [ 0.564375] pnp: PnP ACPI init [ 0.566871] pnp: PnP ACPI: found 6 devices [ 0.583556] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.586925] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.589370] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.591593] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.594141] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.596727] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.598939] NET: Registered protocol family 2 [ 0.601429] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.606852] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.610491] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.615727] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.619149] TCP: Hash tables configured (established 65536 bind 65536) [ 0.621879] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.624735] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.627472] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.630500] NET: Registered protocol family 1 [ 0.633420] RPC: Registered named UNIX socket transport module. [ 0.635769] RPC: Registered udp transport module. [ 0.637743] RPC: Registered tcp transport module. [ 0.639582] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.642060] NET: Registered protocol family 44 [ 0.643841] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.646346] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.648520] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.650822] PCI: CLS 0 bytes, default 64 [ 0.652543] Unpacking initramfs... [ 2.061200] debug: unmapping init [mem 0xffff9577bcc64000-0xffff9577bffcffff] [ 2.064954] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.067344] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.071194] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.587686] Initialise system trusted keyrings [ 2.589475] Key type blacklist registered [ 2.591384] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.600612] zbud: loaded [ 2.603676] *** VALIDATE nfs *** [ 2.605024] *** VALIDATE nfs4 *** [ 2.607372] pstore: using deflate compression [ 2.610687] Platform Keyring initialized [ 2.705275] NET: Registered protocol family 38 [ 2.706560] Key type asymmetric registered [ 2.707500] Asymmetric key parser 'x509' registered [ 2.708592] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.710776] io scheduler mq-deadline registered [ 2.711918] io scheduler kyber registered [ 2.712895] io scheduler bfq registered [ 2.714364] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.716470] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.718344] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.720476] ACPI: Power Button [PWRF] [ 2.724394] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.728975] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.736274] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.762205] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.786866] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.794244] Non-volatile memory driver v1.3 [ 2.795597] Linux agpgart interface v0.103 [ 2.819126] virtio_blk virtio1: [vda] 146200 512-byte logical blocks (74.9 MB/71.4 MiB) [ 2.820813] vda: detected capacity change from 0 to 74854400 [ 2.833798] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.836672] vdb: detected capacity change from 0 to 1073741824 [ 2.844153] libphy: Fixed MDIO Bus: probed [ 2.855183] usbcore: registered new interface driver usbserial_generic [ 2.858815] usbserial: USB Serial support registered for generic [ 2.862292] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.867688] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.869876] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.872594] mousedev: PS/2 mouse device common for all mice [ 2.875768] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.879853] rtc_cmos 00:05: RTC can wake from S4 [ 2.884152] rtc_cmos 00:05: registered as rtc0 [ 2.886116] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.888904] intel_pstate: CPU model not supported [ 2.892829] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.893902] hid: raw HID events driver (C) Jiri Kosina [ 2.903742] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.905345] usbcore: registered new interface driver usbhid [ 2.905350] usbhid: USB HID core driver [ 2.905454] drop_monitor: Initializing network drop monitor service [ 2.905575] Initializing XFRM netlink socket [ 2.905910] NET: Registered protocol family 10 [ 2.908503] Segment Routing with IPv6 [ 2.920299] NET: Registered protocol family 17 [ 2.922553] mpls_gso: MPLS GSO support [ 2.927755] RAS: Correctable Errors collector initialized. [ 2.930251] AVX version of gcm_enc/dec engaged. [ 2.931752] AES CTR mode by8 optimization enabled [ 3.011626] sched_clock: Marking stable (3011528412, 0)->(3955874439, -944346027) [ 3.015219] registered taskstats version 1 [ 3.016752] Loading compiled-in X.509 certificates [ 3.017817] zswap: loaded using pool lzo/zbud [ 3.040919] Key type big_key registered [ 3.053353] Key type encrypted registered [ 3.054899] ima: No TPM chip found, activating TPM-bypass! [ 3.059423] ima: Allocated hash algorithm: sha1 [ 3.061256] ima: No architecture policies found [ 3.062624] evm: Initialising EVM extended attributes: [ 3.064541] evm: security.selinux [ 3.065757] evm: security.ima [ 3.066973] evm: security.capability [ 3.068443] evm: HMAC attrs: 0x1 [ 3.071167] rtc_cmos 00:05: setting system clock to 2026-08-26 08:39:50 UTC (1787733590) [ 3.078404] debug: unmapping init [mem 0xffffffffa7403000-0xffffffffa75fffff] [ 3.081250] debug: unmapping init [mem 0xffffffffa6182000-0xffffffffa6458fff] [ 3.094127] Write protecting the kernel read-only data: 28672k [ 3.098420] debug: unmapping init [mem 0xffffffffa4803000-0xffffffffa49fffff] [ 3.101561] debug: unmapping init [mem 0xffffffffa5114000-0xffffffffa51fffff] [ 3.134123] 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.140617] systemd[1]: Detected virtualization kvm. [ 3.142427] systemd[1]: Detected architecture x86-64. [ 3.145664] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.175488] systemd[1]: No hostname configured. [ 3.177650] systemd[1]: Set hostname to . [ 3.180308] random: systemd: uninitialized urandom read (16 bytes read) [ 3.182937] systemd[1]: Initializing machine ID from random generator. [ 3.336581] random: systemd: uninitialized urandom read (16 bytes read) [ 3.338739] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.347638] random: systemd: uninitialized urandom read (16 bytes read) [ 3.349688] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 3.353667] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Timers. [ OK ] Reached target Slices. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. Starting Journal Service... Starting Setup Virtual Console... [ OK ] Reached target Initrd Root Device. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Apply Kernel Variables... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.535879] device-mapper: uevent: version 1.0.3 [ 4.537725] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 5.466232] scsi host0: ata_piix [ 5.519287] scsi host1: ata_piix [ 5.521981] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.523770] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 5.540633] virtio_net virtio0 ens2: renamed from eth0 [ 9.762963] dracut-initqueue[577]: RTNETLINK answers: File exists [ 10.582852] random: crng init done [ 10.585034] 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. [ 11.792795] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Swap. Stopping udev Kernel Device Manager... [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 13.919671] printk: systemd: 25 output lines suppressed due to ratelimiting [ 14.409772] SELinux: Disabled at runtime. [ 14.492946] 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) [ 14.502240] systemd[1]: Detected virtualization kvm. [ 14.509446] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 15.421913] systemd[1]: initrd-switch-root.service: Succeeded. [ 15.425445] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 15.431080] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 15.435762] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 15.440727] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 15.453735] systemd[1]: Starting Journal Service... Starting Journal Service... [ 15.461073] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Mounting Huge Pages File System... Mounting Kernel Debug File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Created slice system-getty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Listening on udev Kernel Socket. Starting Remount Root and Kernel File Systems... [ OK ] Listening on Process Core Dump Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-serial\x2dgetty.slice. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Activating swap /dev/disk/by-label/SWAP... Starting Apply Kernel Variables... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Stopped target Initrd Root File System. Mounting POSIX Message Queue File System... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. [ 15.753413] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug 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 ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 16.311939] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 16.833284] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 16.881647] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 17.076830] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 17.111917] EDAC sbridge: Ver: 1.1.2 [ 19.510720] Key type dns_resolver registered [ 20.047210] NFS: Registering the id_resolver key type [ 20.050289] Key type id_resolver registered [ 20.052229] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Restore /run/initramfs on shutdown... Starting Network Manager... [ OK ] Reached target sshd-keygen.target. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ 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 Crash recovery kernel arming... Starting Notify NFS peers of a restart... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg137-client login: [ 75.718070] libcfs: loading out-of-tree module taints kernel. [ 76.117949] Key type ._llcrypt registered [ 76.128205] Key type .llcrypt registered [ 76.689199] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 76.714369] alg: No test for adler32 (adler32-zlib) [ 78.520703] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 79.484169] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 81.223160] Key type lgssc registered [ 83.209318] Lustre: Echo OBD driver; http://www.lustre.org/ [ 132.746322] hrtimer: interrupt took 2749874 ns [ 225.804105] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 230.803929] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 244.492800] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing check_logdir /tmp/testlogs/ [ 249.253857] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing yml_node [ 251.361777] Lustre: lustre-OST0000-osc-ffff9578126d2800: disconnect after 23s idle [ 253.353540] Lustre: DEBUG MARKER: Client: 2.17.57.80 [ 255.968978] Lustre: DEBUG MARKER: MDS: 2.17.57.80 [ 258.123204] Lustre: DEBUG MARKER: OSS: 2.17.57.80 [ 259.714564] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Aug 26 04:44:05 EDT 2026 [ 274.055420] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 275.258709] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 277.913404] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 288.203807] Lustre: Unmounted lustre-client [ 401.680150] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 406.539493] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 422.032428] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 455.255563] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 04:47:21 (1787734041) [ 457.053250] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 458.465397] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 04:47:24 (1787734044) [ 488.635454] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 493.318980] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 511.105774] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 511.527103] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 515.430320] Lustre: Unmounted lustre-client [ 541.209953] Key type lgssc unregistered [ 541.479463] LNet: 15026:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 541.487722] LNetError: 15026:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 541.508978] LNet: Removed LNI 192.168.201.37@tcp [ 542.103119] Key type .llcrypt unregistered [ 542.104313] Key type ._llcrypt unregistered [ 555.765809] Key type ._llcrypt registered [ 555.768148] Key type .llcrypt registered [ 556.819615] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 04:49:03 (1787734143) [ 558.179293] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 558.207085] alg: No test for adler32 (adler32-zlib) [ 559.380706] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 559.712225] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 561.511681] Key type lgssc registered [ 562.795899] Lustre: Echo OBD driver; http://www.lustre.org/ [ 627.432846] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 715.492309] Lustre: Unmounted lustre-client [ 740.923882] Key type lgssc unregistered [ 741.233795] LNet: 18837:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 741.239814] LNetError: 18837:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 741.267510] LNet: Removed LNI 192.168.201.37@tcp [ 742.185075] Key type .llcrypt unregistered [ 742.187054] Key type ._llcrypt unregistered [ 751.976468] Key type ._llcrypt registered [ 751.978525] Key type .llcrypt registered [ 753.249217] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 04:52:19 (1787734339) [ 755.642426] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 755.700181] alg: No test for adler32 (adler32-zlib) [ 756.805361] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 757.018547] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 758.671208] Key type lgssc registered [ 759.778833] Lustre: Echo OBD driver; http://www.lustre.org/ [ 810.089887] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 815.217328] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 834.245563] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 836.920644] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 846.645460] Lustre: Unmounted lustre-client [ 872.192935] Key type lgssc unregistered [ 872.433849] LNet: 22438:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 872.439736] LNetError: 22438:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 873.526059] LNet: Removed LNI 192.168.201.37@tcp [ 874.251642] Key type .llcrypt unregistered [ 874.254706] Key type ._llcrypt unregistered [ 884.090543] Key type ._llcrypt registered [ 884.092563] Key type .llcrypt registered [ 885.487728] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 04:54:31 (1787734471) [ 887.740641] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 887.768222] alg: No test for adler32 (adler32-zlib) [ 888.770676] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 889.002219] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 890.663200] Key type lgssc registered [ 891.650438] Lustre: Echo OBD driver; http://www.lustre.org/ [ 935.358917] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 940.150269] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 959.322189] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 961.024948] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 966.667580] Lustre: Unmounted lustre-client [ 992.638632] Key type lgssc unregistered [ 992.880618] LNet: 25632:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 992.900611] LNetError: 25632:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 992.928364] LNet: Removed LNI 192.168.201.37@tcp [ 993.502938] Key type .llcrypt unregistered [ 993.504948] Key type ._llcrypt unregistered [ 1008.521260] Key type ._llcrypt registered [ 1008.526372] Key type .llcrypt registered [ 1009.984857] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 04:56:35 (1787734595) [ 1012.633591] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1012.770973] alg: No test for adler32 (adler32-zlib) [ 1013.806478] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 1014.029260] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 1015.759335] Key type lgssc registered [ 1016.920604] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1066.399740] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1071.501182] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1092.401677] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1095.081119] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 1100.259376] Lustre: lustre-MDT0000-mdc-ffff957804761800: Connection to lustre-MDT0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1105.384136] Lustre: lustre-MDT0001-mdc-ffff957804761800: Connection to lustre-MDT0001 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1112.350103] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1120.607582] Lustre: 26591:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787734692/real 1787734692] req@00000000267950d0 x1874575596983936/t0(0) o400->MGC192.168.201.137@tcp@192.168.201.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1787734708 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1120.648258] LustreError: MGC192.168.201.137@tcp: Connection to MGS (at 192.168.201.137@tcp) was lost; in progress operations using this service will fail [ 1122.682842] Lustre: Unmounted lustre-client [ 1141.468183] Key type lgssc unregistered [ 1141.734717] LNet: 29290:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1141.749591] LNetError: 29290:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1141.775754] LNet: Removed LNI 192.168.201.37@tcp [ 1142.451384] Key type .llcrypt unregistered [ 1142.454510] Key type ._llcrypt unregistered [ 1156.622115] Key type ._llcrypt registered [ 1156.625245] Key type .llcrypt registered [ 1157.893785] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 04:59:03 (1787734743) [ 1160.045884] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1160.061436] alg: No test for adler32 (adler32-zlib) [ 1161.116362] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 1161.333539] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 1162.991145] Key type lgssc registered [ 1164.202741] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1211.129706] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1216.442555] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1235.424326] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1238.358242] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 1243.619733] Lustre: lustre-OST0000-osc-ffff957802b55000: Connection to lustre-OST0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1250.747605] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1261.128814] Lustre: Unmounted lustre-client [ 1288.206645] Key type lgssc unregistered [ 1288.457653] LNet: 32921:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1288.467281] LNetError: 32921:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1288.498667] LNet: Removed LNI 192.168.201.37@tcp [ 1289.186607] Key type .llcrypt unregistered [ 1289.191802] Key type ._llcrypt unregistered [ 1304.868158] Key type ._llcrypt registered [ 1304.870291] Key type .llcrypt registered [ 1306.211093] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 05:01:32 (1787734892) [ 1308.779974] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1308.818625] alg: No test for adler32 (adler32-zlib) [ 1309.974285] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 1310.347554] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 1312.111203] Key type lgssc registered [ 1313.328584] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1358.560910] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1363.414666] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1378.905892] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1385.021733] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 1388.016814] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1390.518511] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1401.871187] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-26 5h03m08s [ 1403.508733] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1405.415061] Lustre: lustre-MDT0000-mdc-ffff957810cb1800: Connection to lustre-MDT0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1412.784583] LustreError: 36707:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff957810cb1800: can't stat MDS #0: rc = -19 [ 1413.925954] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1422.832490] LustreError: MGC192.168.201.137@tcp: Connection to MGS (at 192.168.201.137@tcp) was lost; in progress operations using this service will fail [ 1422.862542] Lustre: Evicted from MGS (at 192.168.201.137@tcp) after server handle changed from 0x9a6e5daba0ee518d to 0x9a6e5daba0ee5530 [ 1422.873923] Lustre: MGC192.168.201.137@tcp: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 1423.516903] Lustre: DEBUG MARKER: Wait for df (36707) ... [ 1423.922202] LustreError: lustre-MDT0000-mdc-ffff957810cb1800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1423.934442] Lustre: lustre-MDT0000-mdc-ffff957810cb1800: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 1424.692283] Lustre: DEBUG MARKER: done [ 1426.163345] Lustre: Unmounted lustre-client [ 1451.334449] Key type lgssc unregistered [ 1451.653961] LNet: 37723:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1451.662919] LNetError: 37723:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1451.682730] LNet: Removed LNI 192.168.201.37@tcp [ 1452.337656] Key type .llcrypt unregistered [ 1452.340758] Key type ._llcrypt unregistered [ 1481.359461] Key type ._llcrypt registered [ 1481.362894] Key type .llcrypt registered [ 1482.667305] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 05:04:28 (1787735068) [ 1485.121573] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1485.166111] alg: No test for adler32 (adler32-zlib) [ 1486.153960] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 1486.400485] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 1488.113060] Key type lgssc registered [ 1489.192685] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1533.995254] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1539.285309] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1555.974479] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1557.710424] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 1561.547497] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-26 5h05m47s [ 1563.224724] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1570.579678] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1572.707158] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1592.799338] Lustre: 41867:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787735160/real 1787735160] req@00000000b7d47f4b x1874576091912320/t0(0) o101->lustre-MDT0000-mdc-ffff9578050ec000@192.168.201.137@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787735180 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1592.823748] Lustre: lustre-MDT0000-mdc-ffff9578050ec000: Connection to lustre-MDT0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1592.867285] Lustre: lustre-MDT0000-mdc-ffff9578050ec000: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 1614.325085] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1617.028678] Lustre: DEBUG MARKER: done [ 1620.615729] Lustre: Unmounted lustre-client [ 1654.257370] Key type lgssc unregistered [ 1654.503456] LNet: 42758:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1654.522697] LNetError: 42758:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1654.542875] LNet: Removed LNI 192.168.201.37@tcp [ 1655.214607] Key type .llcrypt unregistered [ 1655.216485] Key type ._llcrypt unregistered [ 1679.533629] Key type ._llcrypt registered [ 1679.536646] Key type .llcrypt registered [ 1680.484906] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 05:07:46 (1787735266) [ 1681.733879] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1683.200508] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 05:07:49 (1787735269) [ 1686.335323] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1686.353939] alg: No test for adler32 (adler32-zlib) [ 1687.410330] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 1687.728471] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 1689.383132] Key type lgssc registered [ 1690.335820] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1714.729698] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 05:08:21 (1787735301) [ 1741.148744] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1745.966748] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1764.252874] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1766.953120] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 1769.973800] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1772.388412] Lustre: Unmounted lustre-client [ 1782.119262] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1823.964336] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1828.322282] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1828.753756] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 1831.774840] Lustre: Unmounted lustre-client [ 1886.475848] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1891.063255] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1891.642069] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 1894.771756] Lustre: Unmounted lustre-client [ 1911.542248] Lustre: DEBUG MARKER: files compared the same [ 1931.433803] Key type lgssc unregistered [ 1931.643850] LNet: 50381:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1931.651093] LNetError: 50381:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1931.663313] LNet: Removed LNI 192.168.201.37@tcp [ 1932.305419] Key type .llcrypt unregistered [ 1932.307549] Key type ._llcrypt unregistered [ 1944.280278] Key type ._llcrypt registered [ 1944.284570] Key type .llcrypt registered [ 1945.366526] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 05:12:11 (1787735531) [ 1947.223631] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1947.251845] alg: No test for adler32 (adler32-zlib) [ 1948.251065] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 1948.438498] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 1950.071929] Key type lgssc registered [ 1950.976420] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1989.846613] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1994.258357] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2010.746731] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2021.462446] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 2024.993836] Lustre: Unmounted lustre-client [ 2049.965760] Key type lgssc unregistered [ 2050.202921] LNet: 53964:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2050.215937] LNetError: 53964:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2050.229982] LNet: Removed LNI 192.168.201.37@tcp [ 2050.813411] Key type .llcrypt unregistered [ 2050.815060] Key type ._llcrypt unregistered [ 2063.043993] Key type ._llcrypt registered [ 2063.046294] Key type .llcrypt registered [ 2064.199760] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 05:14:10 (1787735650) [ 2065.969451] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2066.095711] alg: No test for adler32 (adler32-zlib) [ 2067.128969] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 2067.311675] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 2068.943490] Key type lgssc registered [ 2069.778781] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2144.965801] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2172.608763] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2177.044730] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2201.560534] Key type lgssc unregistered [ 2201.729651] LNet: 57450:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2201.733592] LNetError: 57450:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2201.744569] LNet: Removed LNI 192.168.201.37@tcp [ 2202.134771] Key type .llcrypt unregistered [ 2202.136839] Key type ._llcrypt unregistered [ 2218.066879] Key type ._llcrypt registered [ 2218.068333] Key type .llcrypt registered [ 2219.352470] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 05:16:45 (1787735805) [ 2223.764597] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2223.808650] alg: No test for adler32 (adler32-zlib) [ 2225.008367] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 2225.365972] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 2227.199424] Key type lgssc registered [ 2228.627463] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2294.750688] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 2302.258589] Lustre: Unmounted lustre-client [ 2336.560369] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 05:18:42 (1787735922) [ 2445.379308] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2466.380138] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 2473.331318] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2473.337228] LustreError: 63926:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff957805bf2800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2473.365297] Lustre: 58433:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.201.137@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2483.697518] Lustre: Unmounted lustre-client [ 2529.093905] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 05:21:54 (1787736114) [ 2545.239067] Key type lgssc unregistered [ 2545.509248] LNet: 65142:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2545.519666] LNetError: 65142:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2545.544723] LNet: Removed LNI 192.168.201.37@tcp [ 2546.153318] Key type .llcrypt unregistered [ 2546.155301] Key type ._llcrypt unregistered [ 2558.572290] Key type ._llcrypt registered [ 2558.575277] Key type .llcrypt registered [ 2559.012517] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2559.024092] alg: No test for adler32 (adler32-zlib) [ 2560.112675] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 2560.423455] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 2562.159308] Key type lgssc registered [ 2563.254390] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2611.838489] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2617.052772] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2636.245512] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2638.801843] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 2642.661125] Lustre: Unmounted lustre-client [ 2667.808435] Key type lgssc unregistered [ 2667.977799] LNet: 68159:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2667.985296] LNetError: 68159:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2668.001929] LNet: Removed LNI 192.168.201.37@tcp [ 2668.642608] Key type .llcrypt unregistered [ 2668.646901] Key type ._llcrypt unregistered [ 2680.260038] Key type ._llcrypt registered [ 2680.261564] Key type .llcrypt registered [ 2680.886065] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2680.913382] alg: No test for adler32 (adler32-zlib) [ 2682.065497] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 2682.321059] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 2684.055522] Key type lgssc registered [ 2684.972121] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2779.195493] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2783.796651] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2801.436096] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2807.380914] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 2809.824023] Lustre: Unmounted lustre-client [ 2834.025313] Key type lgssc unregistered [ 2834.372566] LNet: 71589:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2834.378957] LNetError: 71589:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2834.394241] LNet: Removed LNI 192.168.201.37@tcp [ 2834.885674] Key type .llcrypt unregistered [ 2834.891693] Key type ._llcrypt unregistered [ 2849.100783] Key type ._llcrypt registered [ 2849.102413] Key type .llcrypt registered [ 2850.166906] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 05:27:16 (1787736436) [ 2852.307023] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2852.384604] alg: No test for adler32 (adler32-zlib) [ 2853.426458] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 2853.731040] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 2855.455172] Key type lgssc registered [ 2856.704169] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2897.940828] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2902.667591] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2919.726827] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2926.633975] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 2931.208542] Lustre: Unmounted lustre-client [ 2931.577817] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 2933.958761] Lustre: Unmounted lustre-client [ 2964.567809] Key type lgssc unregistered [ 2964.775863] LNet: 75280:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2964.785032] LNetError: 75280:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2964.800389] LNet: Removed LNI 192.168.201.37@tcp [ 2965.493952] Key type .llcrypt unregistered [ 2965.497235] Key type ._llcrypt unregistered [ 2975.738748] Key type ._llcrypt registered [ 2975.809692] Key type .llcrypt registered [ 2976.157465] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2976.166919] alg: No test for adler32 (adler32-zlib) [ 2977.188475] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 2977.401768] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 2979.079557] Key type lgssc registered [ 2980.070424] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3021.494481] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3026.154861] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3043.993787] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3050.065108] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 3053.561210] Lustre: Unmounted lustre-client [ 3080.663451] Key type lgssc unregistered [ 3080.919495] LNet: 78316:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3080.936381] LNetError: 78316:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3080.959149] LNet: Removed LNI 192.168.201.37@tcp [ 3081.793901] Key type .llcrypt unregistered [ 3081.798346] Key type ._llcrypt unregistered [ 3097.952329] Key type ._llcrypt registered [ 3097.955415] Key type .llcrypt registered [ 3099.135395] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 05:31:25 (1787736685) [ 3101.107137] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3101.129960] alg: No test for adler32 (adler32-zlib) [ 3102.190270] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 3102.443424] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 3104.127228] Key type lgssc registered [ 3105.125481] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3148.572982] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3152.861208] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3171.992448] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3174.622310] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 3185.210029] Lustre: lustre: root_squash is set to 0:0 [ 3185.234147] Lustre: lustre: nosquash_nids is cleared [ 3191.354364] Lustre: lustre: root_squash is set to 500:500 [ 3197.522902] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.201.37@tcp 192.168.0.[2,10]@tcp [ 3206.184433] Lustre: lustre: nosquash_nids set to 192.168.201.37/24@tcp [ 3211.280686] Lustre: Unmounted lustre-client [ 3232.176752] Key type lgssc unregistered [ 3232.413591] LNet: 82282:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3232.423124] LNetError: 82282:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3232.437300] LNet: Removed LNI 192.168.201.37@tcp [ 3233.307658] Key type .llcrypt unregistered [ 3233.309621] Key type ._llcrypt unregistered [ 3249.710344] Key type ._llcrypt registered [ 3249.712614] Key type .llcrypt registered [ 3250.745614] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 05:33:57 (1787736837) [ 3253.399292] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3254.960778] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 05:34:01 (1787736841) [ 3257.194441] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3257.215783] alg: No test for adler32 (adler32-zlib) [ 3258.381319] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 3258.660038] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 3260.383224] Key type lgssc registered [ 3261.567780] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3314.291676] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3319.821598] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3339.361361] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3340.941524] Lustre: lustre: root_squash is set to 500:500 [ 3340.974089] Lustre: lustre: nosquash_nids set to 192.168.201.37/24@tcp [ 3342.106726] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 3346.801299] Lustre: Unmounted lustre-client [ 3376.504717] Key type lgssc unregistered [ 3376.813368] LNet: 86244:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3376.823762] LNetError: 86244:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3376.866605] LNet: Removed LNI 192.168.201.37@tcp [ 3378.079751] Key type .llcrypt unregistered [ 3378.083393] Key type ._llcrypt unregistered [ 3395.813648] Key type ._llcrypt registered [ 3395.815927] Key type .llcrypt registered [ 3397.239389] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3399.022924] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 05:36:24 (1787736984) [ 3422.423459] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3422.460706] alg: No test for adler32 (adler32-zlib) [ 3423.568039] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 3424.041559] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 3425.711140] Key type lgssc registered [ 3426.463117] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3513.959809] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3519.669110] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3542.155513] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3606.005870] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3611.993496] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3632.411122] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3645.421507] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 3676.967729] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9578075f9800.ost_server_uuid 50 [ 3678.611907] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9578075f9800.ost_server_uuid in FULL state after 0 sec [ 3679.077724] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 3683.118391] Lustre: Unmounted lustre-client [ 3685.023344] Lustre: Unmounted lustre-client [ 3727.713705] Key type lgssc unregistered [ 3727.939973] LNet: 93918:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3727.943987] LNetError: 93918:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3728.998845] LNet: Removed LNI 192.168.201.37@tcp [ 3729.586110] Key type .llcrypt unregistered [ 3729.587909] Key type ._llcrypt unregistered [ 3760.057282] Key type ._llcrypt registered [ 3760.058956] Key type .llcrypt registered [ 3761.361834] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 05:42:27 (1787737347) [ 3779.133041] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3779.144424] alg: No test for adler32 (adler32-zlib) [ 3780.203859] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 3780.514710] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 3782.197755] Key type lgssc registered [ 3783.581183] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3858.251959] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3863.299285] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3884.931945] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3887.650978] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 3909.087767] Lustre: 95281:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787737480/real 1787737480] req@000000009438e991 x1874578497344768/t0(0) o400->lustre-OST0000-osc-ffff957808ad4000@192.168.201.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1787737496 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3909.104142] Lustre: lustre-OST0000-osc-ffff957808ad4000: Connection to lustre-OST0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3915.231387] Lustre: 95282:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787737485/real 1787737485] req@000000002223258d x1874578497345280/t0(0) o400->lustre-OST0000-osc-ffff957808ad4000@192.168.201.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1787737501 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3916.341056] Lustre: lustre-OST0000-osc-ffff957808ad4000: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 3919.327954] Lustre: 95281:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787737490/real 1787737490] req@0000000098cf5962 x1874578497345792/t0(0) o400->lustre-OST0000-osc-ffff957808ad4000@192.168.201.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1787737506 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3919.335505] Lustre: lustre-MDT0000-mdc-ffff957808ad4000: Connection to lustre-MDT0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3925.471155] Lustre: 95281:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787737495/real 1787737495] req@0000000010c9cfb2 x1874578497346304/t0(0) o400->lustre-OST0000-osc-ffff957808ad4000@192.168.201.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1787737511 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3934.627281] Lustre: 95284:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787737506/real 1787737506] req@00000000eca9b157 x1874578497348224/t0(0) o400->MGC192.168.201.137@tcp@192.168.201.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1787737522 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3934.659950] LustreError: MGC192.168.201.137@tcp: Connection to MGS (at 192.168.201.137@tcp) was lost; in progress operations using this service will fail [ 3942.989680] Lustre: lustre-MDT0000-mdc-ffff957808ad4000: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 3945.030561] Lustre: Evicted from MGS (at 192.168.201.137@tcp) after server handle changed from 0x5e74b5d2a5e7654 to 0x5e74b5d2a5e79d4 [ 3945.047105] Lustre: MGC192.168.201.137@tcp: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 3949.335104] Lustre: Unmounted lustre-client [ 3976.273767] Key type lgssc unregistered [ 3976.511199] LNet: 99577:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3976.515442] LNetError: 99577:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3976.528582] LNet: Removed LNI 192.168.201.37@tcp [ 3977.286962] Key type .llcrypt unregistered [ 3977.292057] Key type ._llcrypt unregistered [ 3993.781240] Key type ._llcrypt registered [ 3993.784977] Key type .llcrypt registered [ 3995.005370] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 05:46:21 (1787737581) [ 4009.533878] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4009.582833] alg: No test for adler32 (adler32-zlib) [ 4010.678899] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 4010.919114] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 4012.575227] Key type lgssc registered [ 4013.824874] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4049.844108] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4149.675406] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4156.235354] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4179.705352] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4182.611902] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 4184.280659] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4185.924366] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 05:49:32 (1787737772) [ 4393.317471] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4403.666044] Lustre: Unmounted lustre-client [ 4524.171265] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4529.625176] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4552.694120] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4601.920885] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:56:27 (1787738187) [ 4692.758946] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4698.613196] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4719.778184] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4720.366804] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 4723.920517] Lustre: Unmounted lustre-client [ 4750.916681] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:58:56 (1787738336) [ 4847.756307] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4852.526465] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4876.101613] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4877.002535] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 4881.712227] Lustre: Unmounted lustre-client [ 4911.777227] Key type lgssc unregistered [ 4912.178523] LNet: 122602:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4912.203163] LNetError: 122602:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4912.232341] LNet: Removed LNI 192.168.201.37@tcp [ 4913.150777] Key type .llcrypt unregistered [ 4913.153453] Key type ._llcrypt unregistered [ 4929.856839] Key type ._llcrypt registered [ 4929.858829] Key type .llcrypt registered [ 4931.231830] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 06:01:57 (1787738517) [ 4933.817961] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4933.871567] alg: No test for adler32 (adler32-zlib) [ 4934.985603] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 4935.207470] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 4936.904679] Key type lgssc registered [ 4938.349399] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4990.600374] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4995.921728] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5014.207406] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5015.984301] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 5029.696090] Lustre: Unmounted lustre-client [ 5056.252842] Key type lgssc unregistered [ 5056.462899] LNet: 126199:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5056.467655] LNetError: 126199:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5057.533140] LNet: Removed LNI 192.168.201.37@tcp [ 5058.367162] Key type .llcrypt unregistered [ 5058.372662] Key type ._llcrypt unregistered [ 5073.774732] Key type ._llcrypt registered [ 5073.777423] Key type .llcrypt registered [ 5075.038819] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 06:04:21 (1787738661) [ 5077.303029] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5077.343928] alg: No test for adler32 (adler32-zlib) [ 5078.455669] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 5078.721245] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 5080.407304] Key type lgssc registered [ 5081.372718] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5127.787208] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5132.902664] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5154.345984] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5157.168116] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 5162.492504] Lustre: lustre-OST0000-osc-ffff9578050ea000: Connection to lustre-OST0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5175.007376] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff9578050ea000.ost_server_uuid 50 [ 5176.701771] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5187.764549] Lustre: Unmounted lustre-client [ 5209.652917] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 06:06:35 (1787738795) [ 5240.117641] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5245.224552] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5264.499593] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5286.597550] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5287.218547] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 5292.524882] Lustre: lustre-OST0000-osc-ffff957807005800: Connection to lustre-OST0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5325.062140] Lustre: Unmounted lustre-client [ 5366.527763] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 06:09:12 (1787738952) [ 5393.901763] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5399.975430] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5420.174829] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5438.751676] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5439.288920] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 5444.601724] Lustre: lustre-OST0000-osc-ffff957809a7e800: Connection to lustre-OST0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5460.171143] Lustre: Unmounted lustre-client [ 5519.631154] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 06:11:45 (1787739105) [ 5606.069823] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5610.707552] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5633.867399] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5704.257933] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5709.287079] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5728.364767] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5757.758599] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 5803.427744] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5805.016848] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5807.347487] Lustre: Unmounted lustre-client [ 5837.967946] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 06:17:04 (1787739424) [ 5871.907036] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5876.978440] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5897.746933] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5934.439659] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5981.527913] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 6030.527647] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6032.443218] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6044.478622] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6054.825179] Lustre: Unmounted lustre-client [ 6119.978243] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 06:21:46 (1787739706) [ 6156.570566] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6162.894811] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6186.726585] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6187.293631] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 6209.992776] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6211.597741] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6226.469199] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9578075ff800.ost_server_uuid 50 [ 6227.911453] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9578075ff800.ost_server_uuid in IDLE state after 0 sec [ 6231.088439] Lustre: Unmounted lustre-client [ 6231.426745] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6231.430552] Lustre: Skipped 3 previous similar messages [ 6231.548323] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 6232.616635] LustreError: 149619:0:(sec.c:403:import_sec_validate_get()) import 00000000afded3a9 (NEW) with no sec [ 6289.182363] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 06:24:35 (1787739875) [ 6325.613744] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6331.950747] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6355.510204] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6384.555817] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6385.530189] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6385.712821] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 6405.178059] Lustre: Unmounted lustre-client [ 6405.181811] Lustre: Skipped 1 previous similar message [ 6455.752300] Key type lgssc unregistered [ 6456.062034] LNet: 153041:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6456.076741] LNetError: 153041:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6457.128504] LNet: Removed LNI 192.168.201.37@tcp [ 6457.856458] Key type .llcrypt unregistered [ 6457.860496] Key type ._llcrypt unregistered [ 6477.435780] Key type ._llcrypt registered [ 6477.437782] Key type .llcrypt registered [ 6478.659976] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 06:27:44 (1787740064) [ 6480.555483] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6480.573175] alg: No test for adler32 (adler32-zlib) [ 6481.697626] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 6482.065947] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 6483.767198] Key type lgssc registered [ 6485.198467] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6542.248966] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6548.666926] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6577.288342] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6601.753790] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6602.214474] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6602.840210] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 6611.991868] LustreError: lustre-MDT0001-mdc-ffff957802b55000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6612.011398] Lustre: lustre-MDT0001-mdc-ffff957802b55000: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 6618.548519] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6620.462038] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6647.313861] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6651.511601] Lustre: Unmounted lustre-client [ 6683.958722] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 06:31:09 (1787740269) [ 6785.973426] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6794.339669] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6820.840054] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6821.876129] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 6854.900798] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6856.552112] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6870.870592] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6881.188148] Lustre: Unmounted lustre-client [ 6928.589228] Key type lgssc unregistered [ 6928.963850] LNet: 162683:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6928.968547] LNetError: 162683:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6928.980921] LNet: Removed LNI 192.168.201.37@tcp [ 6929.623817] Key type .llcrypt unregistered [ 6929.626109] Key type ._llcrypt unregistered [ 6965.646507] Key type ._llcrypt registered [ 6965.648897] Key type .llcrypt registered [ 6966.911699] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 06:35:52 (1787740552) [ 6969.837659] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6969.866820] alg: No test for adler32 (adler32-zlib) [ 6970.876304] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 6971.159448] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 6972.863204] Key type lgssc registered [ 6974.007787] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7032.341495] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7038.706407] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7060.021532] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7061.820672] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 7111.380232] Lustre: Unmounted lustre-client [ 7150.056390] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7150.444347] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 7186.058804] Lustre: Unmounted lustre-client [ 7216.286746] Key type lgssc unregistered [ 7216.561934] LNet: 167135:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7216.569340] LNetError: 167135:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7216.587574] LNet: Removed LNI 192.168.201.37@tcp [ 7217.633324] Key type .llcrypt unregistered [ 7217.635194] Key type ._llcrypt unregistered [ 7240.199941] Key type ._llcrypt registered [ 7240.203310] Key type .llcrypt registered [ 7241.815186] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 06:40:27 (1787740827) [ 7244.175688] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7244.228671] alg: No test for adler32 (adler32-zlib) [ 7245.278586] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 7245.547837] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 7247.183177] Key type lgssc registered [ 7248.714416] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7304.884878] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7313.698445] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7338.557550] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7350.816256] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 7378.420931] Lustre: Unmounted lustre-client [ 7412.295916] Key type lgssc unregistered [ 7412.716993] LNet: 170898:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7412.728740] LNetError: 170898:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7412.770332] LNet: Removed LNI 192.168.201.37@tcp [ 7413.416382] Key type .llcrypt unregistered [ 7413.419069] Key type ._llcrypt unregistered [ 7433.546631] Key type ._llcrypt registered [ 7433.552561] Key type .llcrypt registered [ 7434.295326] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7434.315777] alg: No test for adler32 (adler32-zlib) [ 7435.441899] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 7435.990710] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 7437.687662] Key type lgssc registered [ 7440.052233] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7501.731546] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7507.742633] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7530.515746] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7532.449954] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 7542.648242] Lustre: Unmounted lustre-client [ 7578.747235] Key type lgssc unregistered [ 7579.006993] LNet: 173968:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7579.020101] LNetError: 173968:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7579.041728] LNet: Removed LNI 192.168.201.37@tcp [ 7579.770987] Key type .llcrypt unregistered [ 7579.773807] Key type ._llcrypt unregistered [ 7597.464904] Key type ._llcrypt registered [ 7597.467670] Key type .llcrypt registered [ 7598.894640] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 06:46:24 (1787741184) [ 7601.954429] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7601.986437] alg: No test for adler32 (adler32-zlib) [ 7603.327715] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 7603.706254] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 7605.463385] Key type lgssc registered [ 7606.900903] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7662.973310] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7669.766775] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7695.805804] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7707.693436] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 7730.887580] Lustre: Unmounted lustre-client [ 7759.290562] Key type lgssc unregistered [ 7759.523674] LNet: 177726:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7759.529866] LNetError: 177726:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7759.549795] LNet: Removed LNI 192.168.201.37@tcp [ 7760.591738] Key type .llcrypt unregistered [ 7760.595714] Key type ._llcrypt unregistered [ 7775.918978] Key type ._llcrypt registered [ 7775.923188] Key type .llcrypt registered [ 7776.542896] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7776.562395] alg: No test for adler32 (adler32-zlib) [ 7777.773892] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 7777.974331] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 7779.727967] Key type lgssc registered [ 7781.240948] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7845.033329] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7853.810955] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7882.262538] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7883.977853] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 7894.955820] Lustre: Unmounted lustre-client [ 7928.369650] Key type lgssc unregistered [ 7928.693709] LNet: 180796:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7928.697767] LNetError: 180796:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7928.742503] LNet: Removed LNI 192.168.201.37@tcp [ 7929.617733] Key type .llcrypt unregistered [ 7929.624805] Key type ._llcrypt unregistered [ 7950.459736] Key type ._llcrypt registered [ 7950.467702] Key type .llcrypt registered [ 7952.720754] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 06:52:17 (1787741537) [ 7979.584369] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7979.594709] alg: No test for adler32 (adler32-zlib) [ 7980.724279] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 7980.956995] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 7982.647256] Key type lgssc registered [ 7984.055263] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8072.765253] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8080.341556] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8107.455215] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8152.951474] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 06:55:38 (1787741738) [ 8189.702569] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8196.683477] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8221.233339] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8224.132508] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 8231.449587] Lustre: Unmounted lustre-client [ 8263.004880] Key type lgssc unregistered [ 8263.449861] LNet: 187902:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8263.465390] LNetError: 187902:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8263.512103] LNet: Removed LNI 192.168.201.37@tcp [ 8264.484148] Key type .llcrypt unregistered [ 8264.486556] Key type ._llcrypt unregistered [ 8285.221647] Key type ._llcrypt registered [ 8285.224679] Key type .llcrypt registered [ 8287.204355] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8290.505226] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 06:57:55 (1787741875) [ 8311.040886] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8311.048660] alg: No test for adler32 (adler32-zlib) [ 8312.057781] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 8312.493268] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 8314.239670] Key type lgssc registered [ 8316.139404] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8427.426844] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8434.906987] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8464.751791] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8490.974246] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8493.960650] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 8522.406717] Lustre: Unmounted lustre-client [ 8663.135221] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8671.265920] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8699.936228] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8748.059206] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 07:05:33 (1787742333) [ 8749.535907] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8751.278380] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 07:05:37 (1787742337) [ 8865.007198] Key type lgssc unregistered [ 8865.332126] LNet: 199368:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8865.339603] LNetError: 199368:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8865.357076] LNet: Removed LNI 192.168.201.37@tcp [ 8866.704641] Key type .llcrypt unregistered [ 8866.710392] Key type ._llcrypt unregistered [ 8887.462761] Key type ._llcrypt registered [ 8887.464649] Key type .llcrypt registered [ 8889.039173] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 07:07:54 (1787742474) [ 8940.700258] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8940.770550] alg: No test for adler32 (adler32-zlib) [ 8942.118425] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 8942.327184] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 8943.976314] Key type lgssc registered [ 8945.494410] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8990.765897] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8996.761551] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9035.613828] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9071.971768] Key type lgssc unregistered [ 9072.309024] LNet: 203105:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9072.322217] LNetError: 203105:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9072.347176] LNet: Removed LNI 192.168.201.37@tcp [ 9073.309624] Key type .llcrypt unregistered [ 9073.311914] Key type ._llcrypt unregistered [ 9091.303893] Key type ._llcrypt registered [ 9091.305716] Key type .llcrypt registered [ 9092.604708] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 07:11:18 (1787742678) [ 9095.875653] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9095.898196] alg: No test for adler32 (adler32-zlib) [ 9097.056227] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 9097.297588] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 9098.943174] Key type lgssc registered [ 9100.503767] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9156.612122] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9162.618670] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9187.533490] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9189.092123] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 9199.593435] Lustre: lustre-MDT0000-mdc-ffff9578050e9800: Connection to lustre-MDT0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9209.836370] Lustre: lustre-MDT0001-mdc-ffff9578050e9800: Connection to lustre-MDT0001 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9221.090096] Lustre: 204093:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787742792/real 1787742792] req@000000001982570a x1874584072699904/t0(0) o400->MGC192.168.201.137@tcp@192.168.201.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1787742808 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9221.138062] LustreError: MGC192.168.201.137@tcp: Connection to MGS (at 192.168.201.137@tcp) was lost; in progress operations using this service will fail [ 9245.803733] Lustre: Evicted from MGS (at 192.168.201.137@tcp) after server handle changed from 0x2defc65263945cfb to 0x2defc6526394763f [ 9245.816783] Lustre: MGC192.168.201.137@tcp: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 9251.815658] Lustre: 206221:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.201.137@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 9274.865597] LustreError: lustre-MDT0000-mdc-ffff9578050e9800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9274.881544] Lustre: lustre-MDT0000-mdc-ffff9578050e9800: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 9284.833975] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9287.199491] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9294.533803] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9296.105825] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9298.696109] Lustre: Unmounted lustre-client [ 9330.705418] Key type lgssc unregistered [ 9330.996913] LNet: 208061:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9331.007501] LNetError: 208061:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9331.034923] LNet: Removed LNI 192.168.201.37@tcp [ 9332.159815] Key type .llcrypt unregistered [ 9332.164556] Key type ._llcrypt unregistered [ 9351.125421] Key type ._llcrypt registered [ 9351.130919] Key type .llcrypt registered [ 9352.927413] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 07:15:38 (1787742938) [ 9355.576126] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9355.748634] alg: No test for adler32 (adler32-zlib) [ 9356.709398] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 9356.878738] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 9358.567340] Key type lgssc registered [ 9359.864617] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9421.658851] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9428.652843] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9481.885961] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9487.511864] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9523.320793] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9546.626629] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9592.028330] Key type lgssc unregistered [ 9592.269751] LNet: 213364:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9592.273413] LNetError: 213364:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9592.286993] LNet: Removed LNI 192.168.201.37@tcp [ 9592.862478] Key type .llcrypt unregistered [ 9592.865931] Key type ._llcrypt unregistered [ 9632.844621] Key type ._llcrypt registered [ 9632.846869] Key type .llcrypt registered [ 9633.860422] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 07:20:20 (1787743220) [ 9685.704626] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9685.843708] alg: No test for adler32 (adler32-zlib) [ 9686.937470] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [ 9687.189183] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [ 9688.919195] Key type lgssc registered [ 9690.284929] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9777.957893] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9782.689657] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9810.766244] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9857.160878] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 07:24:02 (1787743442) [ 9864.283980] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 07:24:10 (1787743450) [ 9903.263672] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9908.183289] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9931.693371] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9934.332628] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [ 9944.191496] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9946.619123] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9948.961451] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9951.128619] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9954.816681] Lustre: lustre-MDT0000-mdc-ffff957805bf2800: Connection to lustre-MDT0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9971.167163] Lustre: 215262:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787743542/real 1787743542] req@00000000fc1040a5 x1874584691288320/t0(0) o400->MGC192.168.201.137@tcp@192.168.201.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1787743558 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9971.199822] LustreError: MGC192.168.201.137@tcp: Connection to MGS (at 192.168.201.137@tcp) was lost; in progress operations using this service will fail [ 9981.429187] Lustre: Evicted from MGS (at 192.168.201.137@tcp) after server handle changed from 0xa7e3b4e9d79910cc to 0xa7e3b4e9d7991246 [ 9981.443353] Lustre: MGC192.168.201.137@tcp: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 9988.704888] Lustre: lustre-MDT0000-mdc-ffff957805bf2800: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [ 9997.961839] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9999.951641] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10003.512881] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10007.026390] Lustre: lustre-MDT0000-mdc-ffff957805bf2800: Connection to lustre-MDT0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [10023.391400] Lustre: 215261:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787743594/real 1787743594] req@00000000a7d2c5f9 x1874584691297280/t0(0) o400->MGC192.168.201.137@tcp@192.168.201.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1787743610 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10023.443544] LustreError: MGC192.168.201.137@tcp: Connection to MGS (at 192.168.201.137@tcp) was lost; in progress operations using this service will fail [10029.672292] Lustre: lustre-MDT0000-mdc-ffff957805bf2800: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [10032.764428] Lustre: Evicted from MGS (at 192.168.201.137@tcp) after server handle changed from 0xa7e3b4e9d7991246 to 0xa7e3b4e9d7991755 [10032.777206] Lustre: MGC192.168.201.137@tcp: Connection restored to 192.168.201.137@tcp (at 192.168.201.137@tcp) [10038.581987] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10039.910266] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10044.413526] Lustre: Unmounted lustre-client [10118.482421] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10125.013753] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10147.786231] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10148.505705] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [10156.408990] Lustre: Unmounted lustre-client [10182.881190] Key type lgssc unregistered [10183.137608] LNet: 225862:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10183.153629] LNetError: 225862:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10183.172080] LNet: Removed LNI 192.168.201.37@tcp [10183.995209] Key type .llcrypt unregistered [10183.997127] Key type ._llcrypt unregistered [10199.280800] Key type ._llcrypt registered [10199.283432] Key type .llcrypt registered [10200.496022] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 07:29:46 (1787743786) [10204.930181] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10204.944676] alg: No test for adler32 (adler32-zlib) [10206.132478] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [10206.540237] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [10208.255540] Key type lgssc registered [10209.554622] Lustre: Echo OBD driver; http://www.lustre.org/ [10262.019572] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10269.126516] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10294.315815] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10306.597307] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [10312.918445] Lustre: Unmounted lustre-client [10376.743379] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10382.053638] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10406.073983] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10406.827453] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [10415.537404] Lustre: Unmounted lustre-client [10489.992694] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10496.363772] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10526.263948] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10527.122371] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [10529.695588] Lustre: Unmounted lustre-client [10555.970797] Key type lgssc unregistered [10556.419855] LNet: 232922:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10556.433537] LNetError: 232922:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10556.470210] LNet: Removed LNI 192.168.201.37@tcp [10557.399812] Key type .llcrypt unregistered [10557.404933] Key type ._llcrypt unregistered [10581.008730] Key type ._llcrypt registered [10581.010233] Key type .llcrypt registered [10582.880639] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 07:36:08 (1787744168) [10585.978934] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10586.034719] alg: No test for adler32 (adler32-zlib) [10587.152177] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [10587.297187] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [10588.911189] Key type lgssc registered [10589.819617] Lustre: Echo OBD driver; http://www.lustre.org/ [10638.367506] Key type lgssc unregistered [10638.744800] LNet: 235247:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10638.752830] LNetError: 235247:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10638.789749] LNet: Removed LNI 192.168.201.37@tcp [10639.655965] Key type .llcrypt unregistered [10639.661744] Key type ._llcrypt unregistered [10671.910932] Key type ._llcrypt registered [10671.913392] Key type .llcrypt registered [10672.755758] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10672.766439] alg: No test for adler32 (adler32-zlib) [10673.903438] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [10674.250515] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [10676.111149] Key type lgssc registered [10677.325350] Lustre: Echo OBD driver; http://www.lustre.org/ [10775.449324] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10782.503101] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10808.018338] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10850.958972] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10854.710554] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 07:40:39 (1787744439) [10897.582935] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10903.835501] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10932.502807] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10958.742443] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10960.079200] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [10965.483692] Lustre: lustre-OST0001-osc-ffff957810cb2000: Connection to lustre-OST0001 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [10972.004947] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10982.330064] Lustre: Unmounted lustre-client [11022.540189] Key type lgssc unregistered [11022.832420] LNet: 242378:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11022.848258] LNetError: 242378:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11022.883288] LNet: Removed LNI 192.168.201.37@tcp [11023.837612] Key type .llcrypt unregistered [11023.840955] Key type ._llcrypt unregistered [11061.530883] Key type ._llcrypt registered [11061.534128] Key type .llcrypt registered [11063.485853] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 07:44:08 (1787744648) [11077.578396] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11077.590811] alg: No test for adler32 (adler32-zlib) [11078.665801] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [11078.977413] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [11080.711204] Key type lgssc registered [11081.986344] Lustre: Echo OBD driver; http://www.lustre.org/ [11142.710092] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11149.636342] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11172.211102] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 07:45:58 (1787744758) [11216.263741] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11223.998398] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11247.967749] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11250.921354] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [11264.758532] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11270.303808] Lustre: Unmounted lustre-client [11394.669622] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11400.401484] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11453.618348] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11454.251418] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [11456.864863] Lustre: Unmounted lustre-client [11496.948941] Key type lgssc unregistered [11497.319763] LNet: 250065:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11497.326752] LNetError: 250065:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11497.349628] LNet: Removed LNI 192.168.201.37@tcp [11498.551662] Key type .llcrypt unregistered [11498.556815] Key type ._llcrypt unregistered [11534.773042] Key type ._llcrypt registered [11534.797972] Key type .llcrypt registered [11535.259589] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11535.271275] alg: No test for adler32 (adler32-zlib) [11536.360726] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [11536.602533] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [11538.272811] Key type lgssc registered [11539.537768] Lustre: Echo OBD driver; http://www.lustre.org/ [11640.477249] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11646.553273] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11682.038634] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11739.261902] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11741.309819] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 07:55:27 (1787745327) [11784.157143] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11790.541956] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11817.215687] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11823.572955] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [11827.278705] Lustre: Unmounted lustre-client [11866.878569] Key type lgssc unregistered [11867.308521] LNet: 256737:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11867.321437] LNetError: 256737:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11867.339582] LNet: Removed LNI 192.168.201.37@tcp [11868.413988] Key type .llcrypt unregistered [11868.415866] Key type ._llcrypt unregistered [11890.143336] Key type ._llcrypt registered [11890.144921] Key type .llcrypt registered [11891.774242] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11894.097351] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 07:57:59 (1787745479) [11903.665618] Key type .llcrypt unregistered [11903.667682] Key type ._llcrypt unregistered [11917.736850] Key type ._llcrypt registered [11917.751101] Key type .llcrypt registered [11918.444858] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11918.463641] alg: No test for adler32 (adler32-zlib) [11919.688604] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [11920.152666] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [11921.927198] Key type lgssc registered [11924.165825] Lustre: Echo OBD driver; http://www.lustre.org/ [11991.229233] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12009.823371] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [12013.595049] Lustre: Unmounted lustre-client [12047.847589] Key type lgssc unregistered [12048.322984] LNet: 260202:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12048.334865] LNetError: 260202:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12048.380410] LNet: Removed LNI 192.168.201.37@tcp [12049.342638] Key type .llcrypt unregistered [12049.345730] Key type ._llcrypt unregistered [12068.551149] Key type ._llcrypt registered [12068.553952] Key type .llcrypt registered [12070.276563] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 08:00:55 (1787745655) [12073.221647] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12073.235467] alg: No test for adler32 (adler32-zlib) [12074.768530] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [12075.043647] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [12076.735263] Key type lgssc registered [12078.219252] Lustre: Echo OBD driver; http://www.lustre.org/ [12167.885070] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12210.884520] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12218.402044] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12220.220465] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [12224.103992] Lustre: Unmounted lustre-client [12266.468280] Key type lgssc unregistered [12266.860618] LNet: 263767:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12266.867125] LNetError: 263767:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12266.928445] LNet: Removed LNI 192.168.201.37@tcp [12268.278830] Key type .llcrypt unregistered [12268.285058] Key type ._llcrypt unregistered [12286.551914] Key type ._llcrypt registered [12286.554898] Key type .llcrypt registered [12288.430200] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 08:04:33 (1787745873) [12291.113247] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12291.163619] alg: No test for adler32 (adler32-zlib) [12292.253558] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [12292.439749] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [12294.135225] Key type lgssc registered [12295.340849] Lustre: Echo OBD driver; http://www.lustre.org/ [12356.830861] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12365.066393] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12394.664871] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12397.481308] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [12402.681148] Lustre: lustre-MDT0000-mdc-ffff957810cb3000: Connection to lustre-MDT0000 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [12405.431158] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12405.458438] LustreError: 266933:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12405.795200] LustreError: MGC192.168.201.137@tcp: Connection to MGS (at 192.168.201.137@tcp) was lost; in progress operations using this service will fail [12405.886943] Lustre: Unmounted lustre-client [12434.956360] Key type lgssc unregistered [12435.489261] LNet: 267351:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12435.503131] LNetError: 267351:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12435.518465] LNet: Removed LNI 192.168.201.37@tcp [12436.734296] Key type .llcrypt unregistered [12436.739537] Key type ._llcrypt unregistered [12460.072324] Key type ._llcrypt registered [12460.076873] Key type .llcrypt registered [12462.213966] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 08:07:27 (1787746047) [12465.400718] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12465.423936] alg: No test for adler32 (adler32-zlib) [12466.761633] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [12467.129692] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [12468.935159] Key type lgssc registered [12470.315770] Lustre: Echo OBD driver; http://www.lustre.org/ [12539.266847] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12547.464662] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12574.381181] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12581.473404] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [12586.489934] Lustre: lustre-MDT0001-mdc-ffff95780933f800: Connection to lustre-MDT0001 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [12600.859617] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12604.310510] Lustre: Unmounted lustre-client [12625.453540] Key type lgssc unregistered [12626.080199] LNet: 270943:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12626.095204] LNetError: 270943:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12627.116651] LNet: Removed LNI 192.168.201.37@tcp [12628.223652] Key type .llcrypt unregistered [12628.230939] Key type ._llcrypt unregistered [12651.954839] Key type ._llcrypt registered [12651.956224] Key type .llcrypt registered [12653.971647] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 08:10:39 (1787746239) [12677.948890] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12678.035624] alg: No test for adler32 (adler32-zlib) [12679.300277] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [12679.624269] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [12681.375768] Key type lgssc registered [12682.906829] Lustre: Echo OBD driver; http://www.lustre.org/ [12822.395208] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12825.317396] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [12877.804461] Lustre: lustre-MDT0001-mdc-ffff957814026800: Connection to lustre-MDT0001 (at 192.168.201.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [12890.217913] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12900.638652] Lustre: Unmounted lustre-client [12933.452845] Key type lgssc unregistered [12933.879818] LNet: 276740:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12933.893510] LNetError: 276740:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12933.923178] LNet: Removed LNI 192.168.201.37@tcp [12934.812097] Key type .llcrypt unregistered [12934.815479] Key type ._llcrypt unregistered [12952.830990] Key type ._llcrypt registered [12952.832430] Key type .llcrypt registered [12954.585089] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 08:15:40 (1787746540) [12957.792961] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12960.896540] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 08:15:45 (1787746545) [12963.412129] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12965.492552] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 08:15:51 (1787746551) [12967.882692] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12970.431492] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 08:15:55 (1787746555) [12972.142573] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12975.356142] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 08:16:00 (1787746560) [12977.097570] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12978.890955] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 08:16:05 (1787746565) [12990.883474] Key type .llcrypt unregistered [12990.887222] Key type ._llcrypt unregistered [13001.840970] Key type ._llcrypt registered [13001.842698] Key type .llcrypt registered [13002.057789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13002.109616] alg: No test for adler32 (adler32-zlib) [13003.295681] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [13003.498764] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [13005.199792] Key type lgssc registered [13007.500647] Lustre: Echo OBD driver; http://www.lustre.org/ [13099.782791] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13106.021825] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13138.839869] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13141.956636] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [13147.054118] Lustre: Unmounted lustre-client [13184.024352] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 08:19:29 (1787746769) [13225.806763] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13235.665837] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13273.876828] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13274.494850] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [13277.754449] Lustre: Unmounted lustre-client [13322.656233] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 08:21:48 (1787746908) [13330.143579] LNet: 1 local NIs in recovery (showing 1): 192.168.201.37@tcp [13987.342631] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13994.849788] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14034.564577] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14157.708739] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 08:35:42 (1787747742) [14171.676877] Key type lgssc unregistered [14172.028870] LNet: 290297:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14172.034526] LNetError: 290297:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14172.061260] LNet: Removed LNI 192.168.201.37@tcp [14173.026382] Key type .llcrypt unregistered [14173.032596] Key type ._llcrypt unregistered [14282.356859] Key type ._llcrypt registered [14282.360115] Key type .llcrypt registered [14283.127801] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14283.181118] alg: No test for adler32 (adler32-zlib) [14284.323975] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [14284.572086] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [14286.247923] Key type lgssc registered [14287.767294] Lustre: Echo OBD driver; http://www.lustre.org/ [14384.480229] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14390.440193] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14420.679189] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14463.214810] Key type lgssc unregistered [14463.492815] LNet: 294001:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14463.498827] LNetError: 294001:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14463.517376] LNet: Removed LNI 192.168.201.37@tcp [14464.181737] Key type .llcrypt unregistered [14464.183900] Key type ._llcrypt unregistered [14501.509321] Key type ._llcrypt registered [14501.510978] Key type .llcrypt registered [14502.832744] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 08:41:28 (1787748088) [14525.924453] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14526.041275] alg: No test for adler32 (adler32-zlib) [14527.208369] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [14527.403986] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [14529.039190] Key type lgssc registered [14530.670438] Lustre: Echo OBD driver; http://www.lustre.org/ [14596.690862] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 08:43:02 (1787748182) [14612.351169] Key type lgssc unregistered [14612.596670] LNet: 297563:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14612.602327] LNetError: 297563:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14612.615589] LNet: Removed LNI 192.168.201.37@tcp [14613.384830] Key type .llcrypt unregistered [14613.388182] Key type ._llcrypt unregistered [14630.592770] Key type ._llcrypt registered [14630.604315] Key type .llcrypt registered [14631.722716] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14631.735581] alg: No test for adler32 (adler32-zlib) [14632.998697] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [14633.259089] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [14634.951260] Key type lgssc registered [14636.866371] Lustre: Echo OBD driver; http://www.lustre.org/ [14704.310410] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14710.433368] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14740.413979] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15088.219419] LNet: Added LNI 192.168.201.37@tcp50 [8/256/0/180] [15090.567843] LNet: Removed LNI 192.168.201.37@tcp [15092.677567] Lustre: 301972:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff957810ca1000: config has no valid NIDs, force dynamic NIDs [15093.938925] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [15094.049397] Lustre: Unmounted lustre-client [15097.294963] Key type lgssc unregistered [15097.694257] LNet: 302235:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15097.700812] LNetError: 302235:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15097.718438] LNet: Removed LNI 192.168.201.37@tcp50 [15098.414924] Key type .llcrypt unregistered [15098.418346] Key type ._llcrypt unregistered [15119.023537] Key type ._llcrypt registered [15119.039206] Key type .llcrypt registered [15119.730851] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15119.746502] alg: No test for adler32 (adler32-zlib) [15121.166385] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [15121.729377] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [15123.575127] Key type lgssc registered [15125.152486] Lustre: Echo OBD driver; http://www.lustre.org/ [15190.461900] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15196.817644] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15206.013882] LNet: Added LNI 192.168.201.37@tcp50 [8/256/0/180] [15206.885927] LNet: Removed LNI 192.168.201.37@tcp [15208.123953] Lustre: 304927:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff95780a697000: config has no valid NIDs, force dynamic NIDs [15209.433330] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [15209.967223] Lustre: Unmounted lustre-client [15248.150982] Key type lgssc unregistered [15248.631461] LNet: 305801:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15248.644752] LNetError: 305801:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15248.660168] LNet: Removed LNI 192.168.201.37@tcp50 [15249.629135] Key type .llcrypt unregistered [15249.631912] Key type ._llcrypt unregistered [15263.127877] Key type ._llcrypt registered [15263.129596] Key type .llcrypt registered [15264.749684] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 08:54:10 (1787748850) [15286.946404] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15286.973666] alg: No test for adler32 (adler32-zlib) [15288.197317] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [15288.549063] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [15290.327276] Key type lgssc registered [15291.700941] Lustre: Echo OBD driver; http://www.lustre.org/ [15391.583480] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15399.814963] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15430.216519] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15465.609915] Key type lgssc unregistered [15466.036557] LNet: 310553:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15466.093677] LNetError: 310553:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15466.123818] LNet: Removed LNI 192.168.201.37@tcp [15467.090214] Key type .llcrypt unregistered [15467.095194] Key type ._llcrypt unregistered [15480.687823] Key type ._llcrypt registered [15480.692333] Key type .llcrypt registered [15482.113764] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 08:57:47 (1787749067) [15485.817781] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15485.847350] alg: No test for adler32 (adler32-zlib) [15487.047536] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [15487.421506] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [15489.112594] Key type lgssc registered [15490.482571] Lustre: Echo OBD driver; http://www.lustre.org/ [15550.094994] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15556.335858] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15579.694788] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15590.989587] Lustre: Mounted lustre-client - version 2.17.57_80_g6de652b [15660.038488] Lustre: Mounted fs15246-client - version 2.17.57_80_g6de652b [15678.616073] Lustre: Unmounted fs15246-client [15708.237973] Lustre: Unmounted lustre-client [15748.186022] Key type lgssc unregistered [15748.622916] LNet: 315432:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15748.645133] LNetError: 315432:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15748.663933] LNet: Removed LNI 192.168.201.37@tcp [15749.639376] Key type .llcrypt unregistered [15749.641878] Key type ._llcrypt unregistered [15765.396752] Key type ._llcrypt registered [15765.400521] Key type .llcrypt registered [15766.812349] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 09:02:32 (1787749352) [15768.922064] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15769.042913] alg: No test for adler32 (adler32-zlib) [15770.363053] Lustre: Lustre: Build Version: 2.17.57_80_g6de652b [15770.804250] LNet: Added LNI 192.168.201.37@tcp [8/256/0/180] [15772.615194] Key type lgssc registered [15774.512559] Lustre: Echo OBD driver; http://www.lustre.org/ [15940.369422] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15947.983458] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15978.484920] Lustre: DEBUG MARKER: oleg137-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16096.755721] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15835 sec ========= 09:08:02 (1787749682) [16099.009132] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 09:08:04 (1787749684) === [16103.631784] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 09:08:09 (1787749689) === [16143.361212] Key type lgssc unregistered [16143.858213] LNet: 324708:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16143.867362] LNetError: 324708:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16143.889110] LNet: Removed LNI 192.168.201.37@tcp [16144.865777] Key type .llcrypt unregistered [16144.869282] Key type ._llcrypt unregistered