[ 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 425631670 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: 2895288K/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.001013] APIC: Switch to symmetric I/O mode setup [ 0.003195] x2apic enabled [ 0.004022] Switched APIC routing to physical x2apic. [ 0.005011] kvm-guest: setup PV IPIs [ 0.008000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009018] pid_max: default: 32768 minimum: 301 [ 0.010162] LSM: Security Framework initializing [ 0.011064] Yama: becoming mindful. [ 0.012044] SELinux: Initializing. [ 0.013078] *** VALIDATE selinux *** [ 0.021406] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026616] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027199] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028116] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029128] *** VALIDATE tmpfs *** [ 0.030483] *** VALIDATE proc *** [ 0.031256] *** VALIDATE cgroup *** [ 0.033008] *** VALIDATE cgroup2 *** [ 0.034305] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036063] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038031] Spectre V2 : User space: Vulnerable [ 0.039012] Speculative Store Bypass: Vulnerable [ 0.041882] debug: unmapping init [mem 0xffffffffa5459000-0xffffffffa5460fff] [ 0.043203] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044666] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045028] ... version: 2 [ 0.046015] ... bit width: 48 [ 0.047015] ... generic registers: 4 [ 0.048013] ... value mask: 0000ffffffffffff [ 0.049018] ... max period: 00007fffffffffff [ 0.050016] ... fixed-purpose events: 3 [ 0.051013] ... event mask: 000000070000000f [ 0.052323] rcu: Hierarchical SRCU implementation. [ 0.054556] smp: Bringing up secondary CPUs ... [ 0.055580] x86: Booting SMP configuration: [ 0.056029] .... node #0, CPUs: #1 #2 #3 [ 0.059301] smp: Brought up 1 node, 4 CPUs [ 0.061012] smpboot: Max logical packages: 1 [ 0.062023] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.118280] node 0 deferred pages initialised in 54ms [ 0.121008] devtmpfs: initialized [ 0.121955] x86/mm: Memory block size: 128MB [ 0.123154] gcov: version magic: 0x41383552 [ 0.125198] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.126062] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.127232] pinctrl core: initialized pinctrl subsystem [ 0.128136] [ 0.128454] ************************************************************* [ 0.129014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.130010] ** ** [ 0.131011] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.132013] ** ** [ 0.133012] ** This means that this kernel is built to expose internal ** [ 0.134010] ** IOMMU data structures, which may compromise security on ** [ 0.135012] ** your system. ** [ 0.136012] ** ** [ 0.137010] ** If you see this message and you are not debugging the ** [ 0.138009] ** kernel, report this immediately to your vendor! ** [ 0.139014] ** ** [ 0.140013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.141011] ************************************************************* [ 0.142844] NET: Registered protocol family 16 [ 0.143476] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.144069] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.145073] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.146475] cpuidle: using governor menu [ 0.148277] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.150475] PCI: Using configuration type 1 for base access [ 0.152097] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.158088] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.159034] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.161058] cryptd: max_cpu_qlen set to 1000 [ 0.162186] ACPI: Added _OSI(Module Device) [ 0.163012] ACPI: Added _OSI(Processor Device) [ 0.163875] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.164009] ACPI: Added _OSI(Processor Aggregator Device) [ 0.167056] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.169451] ACPI: Interpreter enabled [ 0.170049] ACPI: PM: (supports S0 S3 S4 S5) [ 0.171012] ACPI: Using IOAPIC for interrupt routing [ 0.172124] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.173272] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.180633] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.181033] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.182015] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.183074] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.185020] acpiphp: Slot [2] registered [ 0.186050] acpiphp: Slot [5] registered [ 0.187093] acpiphp: Slot [6] registered [ 0.188014] acpiphp: Slot [3] registered [ 0.188929] acpiphp: Slot [4] registered [ 0.189054] acpiphp: Slot [7] registered [ 0.189856] acpiphp: Slot [8] registered [ 0.190059] acpiphp: Slot [9] registered [ 0.190887] acpiphp: Slot [10] registered [ 0.191055] acpiphp: Slot [11] registered [ 0.191898] acpiphp: Slot [12] registered [ 0.192078] acpiphp: Slot [13] registered [ 0.193111] acpiphp: Slot [14] registered [ 0.194073] acpiphp: Slot [15] registered [ 0.194974] acpiphp: Slot [16] registered [ 0.195081] acpiphp: Slot [17] registered [ 0.195986] acpiphp: Slot [18] registered [ 0.196091] acpiphp: Slot [19] registered [ 0.197079] acpiphp: Slot [20] registered [ 0.198079] acpiphp: Slot [21] registered [ 0.199099] acpiphp: Slot [22] registered [ 0.200103] acpiphp: Slot [23] registered [ 0.201081] acpiphp: Slot [24] registered [ 0.201884] acpiphp: Slot [25] registered [ 0.202121] acpiphp: Slot [26] registered [ 0.203091] acpiphp: Slot [27] registered [ 0.204099] acpiphp: Slot [28] registered [ 0.205120] acpiphp: Slot [29] registered [ 0.206079] acpiphp: Slot [30] registered [ 0.207120] acpiphp: Slot [31] registered [ 0.208056] PCI host bridge to bus 0000:00 [ 0.209014] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.210012] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.211018] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.212026] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.213028] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.214030] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.215174] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.216696] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.217843] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.221310] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.223425] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.224015] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.225022] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.226014] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.227444] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.228460] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.229038] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.230702] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.232017] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.237016] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.239567] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.242622] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.245076] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.247018] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.252012] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.257545] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.266016] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.274028] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.293020] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.303944] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.306415] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.308311] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.310349] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.313254] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.317093] iommu: Default domain type: Passthrough [ 0.319596] SCSI subsystem initialized [ 0.321127] ACPI: bus type USB registered [ 0.322130] usbcore: registered new interface driver usbfs [ 0.325102] usbcore: registered new interface driver hub [ 0.326073] usbcore: registered new device driver usb [ 0.327167] pps_core: LinuxPPS API ver. 1 registered [ 0.328008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.330049] PTP clock support registered [ 0.332062] EDAC MC: Ver: 3.0.0 [ 0.333391] PCI: Using ACPI for IRQ routing [ 0.335819] NetLabel: Initializing [ 0.337012] NetLabel: domain hash size = 128 [ 0.338010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.340099] NetLabel: unlabeled traffic allowed by default [ 0.343130] vgaarb: loaded [ 0.345048] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.347018] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.355184] clocksource: Switched to clocksource kvm-clock [ 0.466189] VFS: Disk quotas dquot_6.6.0 [ 0.467425] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.469857] *** VALIDATE ramfs *** [ 0.471053] *** VALIDATE hugetlbfs *** [ 0.473353] pnp: PnP ACPI init [ 0.475494] pnp: PnP ACPI: found 6 devices [ 0.495267] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.498753] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.501053] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.503312] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.505892] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.508277] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.511197] NET: Registered protocol family 2 [ 0.513752] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.519278] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.523407] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.528603] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.532057] TCP: Hash tables configured (established 65536 bind 65536) [ 0.535114] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.538461] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.541430] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.543680] NET: Registered protocol family 1 [ 0.546204] RPC: Registered named UNIX socket transport module. [ 0.548462] RPC: Registered udp transport module. [ 0.550150] RPC: Registered tcp transport module. [ 0.551879] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.554165] NET: Registered protocol family 44 [ 0.555874] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.558170] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.560282] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.562628] PCI: CLS 0 bytes, default 64 [ 0.565301] Unpacking initramfs... [ 1.962519] debug: unmapping init [mem 0xffff8abefcc64000-0xffff8abefffcffff] [ 1.966605] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 1.968823] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 1.971707] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.423359] Initialise system trusted keyrings [ 2.424770] Key type blacklist registered [ 2.426570] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.434447] zbud: loaded [ 2.436896] *** VALIDATE nfs *** [ 2.438048] *** VALIDATE nfs4 *** [ 2.439504] pstore: using deflate compression [ 2.442422] Platform Keyring initialized [ 2.535493] NET: Registered protocol family 38 [ 2.537972] Key type asymmetric registered [ 2.540760] Asymmetric key parser 'x509' registered [ 2.543064] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.546819] io scheduler mq-deadline registered [ 2.548879] io scheduler kyber registered [ 2.550666] io scheduler bfq registered [ 2.552464] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.555499] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.558180] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.560426] ACPI: Power Button [PWRF] [ 2.565480] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.570732] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.576696] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.601070] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.627450] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.630692] Non-volatile memory driver v1.3 [ 2.632071] Linux agpgart interface v0.103 [ 2.658056] virtio_blk virtio1: [vda] 146016 512-byte logical blocks (74.8 MB/71.3 MiB) [ 2.660190] vda: detected capacity change from 0 to 74760192 [ 2.676301] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.679370] vdb: detected capacity change from 0 to 1073741824 [ 2.686451] libphy: Fixed MDIO Bus: probed [ 2.694112] usbcore: registered new interface driver usbserial_generic [ 2.696642] usbserial: USB Serial support registered for generic [ 2.699057] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.703480] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.704812] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.706296] mousedev: PS/2 mouse device common for all mice [ 2.707990] rtc_cmos 00:05: RTC can wake from S4 [ 2.709988] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.712206] rtc_cmos 00:05: registered as rtc0 [ 2.714748] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.717264] intel_pstate: CPU model not supported [ 2.719673] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.722770] hid: raw HID events driver (C) Jiri Kosina [ 2.724943] usbcore: registered new interface driver usbhid [ 2.726838] usbhid: USB HID core driver [ 2.726990] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.728328] drop_monitor: Initializing network drop monitor service [ 2.732370] Initializing XFRM netlink socket [ 2.734199] NET: Registered protocol family 10 [ 2.736909] Segment Routing with IPv6 [ 2.737728] NET: Registered protocol family 17 [ 2.738788] mpls_gso: MPLS GSO support [ 2.745493] RAS: Correctable Errors collector initialized. [ 2.747218] AVX version of gcm_enc/dec engaged. [ 2.748258] AES CTR mode by8 optimization enabled [ 2.817386] sched_clock: Marking stable (2817312158, 0)->(3788049896, -970737738) [ 2.819986] registered taskstats version 1 [ 2.821571] Loading compiled-in X.509 certificates [ 2.824046] zswap: loaded using pool lzo/zbud [ 2.846976] Key type big_key registered [ 2.860699] Key type encrypted registered [ 2.862132] ima: No TPM chip found, activating TPM-bypass! [ 2.863850] ima: Allocated hash algorithm: sha1 [ 2.865320] ima: No architecture policies found [ 2.866923] evm: Initialising EVM extended attributes: [ 2.868774] evm: security.selinux [ 2.869977] evm: security.ima [ 2.871083] evm: security.capability [ 2.872286] evm: HMAC attrs: 0x1 [ 2.874059] rtc_cmos 00:05: setting system clock to 2026-08-21 18:52:33 UTC (1787338353) [ 2.880219] debug: unmapping init [mem 0xffffffffa6403000-0xffffffffa65fffff] [ 2.882377] debug: unmapping init [mem 0xffffffffa5182000-0xffffffffa5458fff] [ 2.890068] Write protecting the kernel read-only data: 28672k [ 2.892518] debug: unmapping init [mem 0xffffffffa3803000-0xffffffffa39fffff] [ 2.894357] debug: unmapping init [mem 0xffffffffa4114000-0xffffffffa41fffff] [ 2.919684] 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) [ 2.926782] systemd[1]: Detected virtualization kvm. [ 2.928868] systemd[1]: Detected architecture x86-64. [ 2.930818] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 2.954297] systemd[1]: No hostname configured. [ 2.955504] systemd[1]: Set hostname to . [ 2.957408] random: systemd: uninitialized urandom read (16 bytes read) [ 2.959855] systemd[1]: Initializing machine ID from random generator. [ 2.992932] random: ln: uninitialized urandom read (6 bytes read) [ 3.086893] random: systemd: uninitialized urandom read (16 bytes read) [ 3.089271] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 3.093895] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 3.097623] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket. Starting Create Volatile Files and Directories... Starting Journal Service... Starting Setup Virtual Console... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. Starting Apply Kernel Variables... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Slices. [ OK ] Reached target Local Encrypted Volumes. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Initrd Root Device. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.634682] device-mapper: uevent: version 1.0.3 [ 3.636753] 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. [ 4.266235] virtio_net virtio0 ens2: renamed from eth0 [ 4.309416] scsi host0: ata_piix [ 4.317192] scsi host1: ata_piix [ 4.319063] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.321468] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.415697] random: crng init done [ 9.429151] random: 7 urandom warning(s) missed due to ratelimiting [ 9.767052] dracut-initqueue[588]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 11.618168] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 14.684751] printk: systemd: 26 output lines suppressed due to ratelimiting [ 15.425739] SELinux: Disabled at runtime. [ 15.557807] 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) [ 15.566720] systemd[1]: Detected virtualization kvm. [ 15.568710] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 17.350517] systemd[1]: initrd-switch-root.service: Succeeded. [ 17.355160] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 17.366701] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 17.376517] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 17.382970] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 17.398276] systemd[1]: Starting Journal Service... Starting Journal Service... [ 17.410428] systemd[1]: Reached target rpc_pipefs.target. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice User and Session Slice. Mounting POSIX Message Queue File System... [ OK ] Listening on initctl Compatibility Named Pipe. Mounting Kernel Debug File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Mounting Huge Pages File System... [ OK ] Created slice system-getty.slice. [ OK ] Listening on Process Core Dump Socket. [ OK ] Reached target Slices. Starting Apply Kernel Variables... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Created slice system-serial\x2dgetty.slice. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Reached target RPC Port Mapper. Starting Remount Root and Kernel File Systems... Activating swap /dev/disk/by-label/SWAP... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on udev Control Socket.[ 17.967907] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started udev Coldplug all Devices. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 19.028989] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 20.328879] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 20.348295] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 21.106894] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 21.288820] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit) [** ] A start job is running for Configur…-only root support (8s / no limit)[ 25.751800] Key type dns_resolver registered [*** ] A start job is running for Configur…-only root support (9s / no limit)[ 26.480986] NFS: Registering the id_resolver key type [ 26.487850] Key type id_resolver registered [ 26.493376] Key type id_legacy registered [ *** ] A start job is running for Configur…-only root support (9s / no limit) [ *** ] A start job is running for Configur…-only root support (9s / no limit) [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting 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 daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ 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. Starting Login Service... [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg239-client login: [ 112.373208] libcfs: loading out-of-tree module taints kernel. [ 112.595054] Key type ._llcrypt registered [ 112.596641] Key type .llcrypt registered [ 113.535228] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 113.566109] alg: No test for adler32 (adler32-zlib) [ 115.318278] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 116.201106] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 118.031477] Key type lgssc registered [ 119.398780] Lustre: Echo OBD driver; http://www.lustre.org/ [ 178.512169] hrtimer: interrupt took 5159974 ns [ 291.126457] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 296.102668] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 310.932198] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing check_logdir /tmp/testlogs/ [ 316.903747] Lustre: lustre-OST0000-osc-ffff8abf4841f000: disconnect after 23s idle [ 317.390564] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing yml_node [ 322.632445] Lustre: DEBUG MARKER: Client: 2.17.57.44 [ 326.391707] Lustre: DEBUG MARKER: MDS: 2.17.57.44 [ 329.811740] Lustre: DEBUG MARKER: OSS: 2.17.57.44 [ 332.003246] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Aug 21 14:58:00 EDT 2026 [ 353.241733] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 356.233668] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 360.241372] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 370.619926] Lustre: Unmounted lustre-client [ 480.180873] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 486.158672] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 507.493412] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 562.920613] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 15:01:51 (1787338911) [ 566.087969] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 568.111731] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 15:01:57 (1787338917) [ 599.600515] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 605.436851] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 625.686863] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 626.435324] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 631.788213] Lustre: Unmounted lustre-client [ 661.269696] Key type lgssc unregistered [ 661.494225] LNet: 15045:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 661.503796] LNetError: 15045:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 661.523747] LNet: Removed LNI 192.168.202.39@tcp [ 662.297177] Key type .llcrypt unregistered [ 662.298683] Key type ._llcrypt unregistered [ 677.637267] Key type ._llcrypt registered [ 677.640745] Key type .llcrypt registered [ 678.981179] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 15:03:48 (1787339028) [ 680.467243] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 680.529086] alg: No test for adler32 (adler32-zlib) [ 681.699357] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 681.990439] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 683.655388] Key type lgssc registered [ 685.226747] Lustre: Echo OBD driver; http://www.lustre.org/ [ 768.141690] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 855.862182] Lustre: Unmounted lustre-client [ 883.720171] Key type lgssc unregistered [ 883.978065] LNet: 18850:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 883.982602] LNetError: 18850:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 884.006276] LNet: Removed LNI 192.168.202.39@tcp [ 884.765782] Key type .llcrypt unregistered [ 884.767599] Key type ._llcrypt unregistered [ 896.835633] Key type ._llcrypt registered [ 896.837895] Key type .llcrypt registered [ 898.530552] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 15:07:27 (1787339247) [ 901.663818] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 901.774717] alg: No test for adler32 (adler32-zlib) [ 902.812311] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 903.008457] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 904.680569] Key type lgssc registered [ 906.610460] Lustre: Echo OBD driver; http://www.lustre.org/ [ 964.114989] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 970.495542] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 995.541634] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1007.679845] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 1018.911679] Lustre: Unmounted lustre-client [ 1056.344992] Key type lgssc unregistered [ 1056.635281] LNet: 22456:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1056.643753] LNetError: 22456:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1056.656347] LNet: Removed LNI 192.168.202.39@tcp [ 1057.461187] Key type .llcrypt unregistered [ 1057.470103] Key type ._llcrypt unregistered [ 1069.014976] Key type ._llcrypt registered [ 1069.016546] Key type .llcrypt registered [ 1070.185581] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 15:10:19 (1787339419) [ 1073.210487] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1073.233537] alg: No test for adler32 (adler32-zlib) [ 1074.379849] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 1074.642480] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 1076.336286] Key type lgssc registered [ 1077.591448] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1133.198990] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1139.935794] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1160.593886] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1162.295528] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 1171.296960] Lustre: Unmounted lustre-client [ 1199.477608] Key type lgssc unregistered [ 1199.845904] LNet: 25654:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1199.856814] LNetError: 25654:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1199.883216] LNet: Removed LNI 192.168.202.39@tcp [ 1200.984611] Key type .llcrypt unregistered [ 1200.996865] Key type ._llcrypt unregistered [ 1217.812055] Key type ._llcrypt registered [ 1217.815894] Key type .llcrypt registered [ 1219.342913] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 15:12:48 (1787339568) [ 1222.159106] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1222.187364] alg: No test for adler32 (adler32-zlib) [ 1223.407805] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 1223.776479] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 1225.479284] Key type lgssc registered [ 1226.776877] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1279.647594] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1286.128925] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1309.550763] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1312.417931] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 1317.880105] Lustre: lustre-MDT0000-mdc-ffff8abf48418800: Connection to lustre-MDT0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1322.985103] Lustre: lustre-MDT0001-mdc-ffff8abf48418800: Connection to lustre-MDT0001 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1330.128475] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1334.239961] Lustre: 26617:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787339668/real 1787339668] req@00000000f05b36b1 x1874161381151616/t0(0) o400->MGC192.168.202.139@tcp@192.168.202.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1787339684 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1334.271792] LustreError: MGC192.168.202.139@tcp: Connection to MGS (at 192.168.202.139@tcp) was lost; in progress operations using this service will fail [ 1340.456480] Lustre: Unmounted lustre-client [ 1360.524595] Key type lgssc unregistered [ 1360.842257] LNet: 29317:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1360.851263] LNetError: 29317:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1360.884228] LNet: Removed LNI 192.168.202.39@tcp [ 1361.672152] Key type .llcrypt unregistered [ 1361.675577] Key type ._llcrypt unregistered [ 1377.963861] Key type ._llcrypt registered [ 1377.968159] Key type .llcrypt registered [ 1379.560346] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 15:15:28 (1787339728) [ 1382.412250] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1382.447368] alg: No test for adler32 (adler32-zlib) [ 1383.622155] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 1383.899151] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 1385.576350] Key type lgssc registered [ 1387.359815] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1444.065881] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1451.076367] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1474.092302] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1486.391181] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 1496.572789] Lustre: lustre-OST0000-osc-ffff8abf435c3800: Connection to lustre-OST0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1501.379729] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1511.800350] Lustre: Unmounted lustre-client [ 1551.694568] Key type lgssc unregistered [ 1552.247355] LNet: 32934:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1552.255216] LNetError: 32934:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1552.266830] LNet: Removed LNI 192.168.202.39@tcp [ 1553.520393] Key type .llcrypt unregistered [ 1553.522937] Key type ._llcrypt unregistered [ 1572.432860] Key type ._llcrypt registered [ 1572.438956] Key type .llcrypt registered [ 1574.138566] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 15:18:42 (1787339922) [ 1576.670099] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1576.686648] alg: No test for adler32 (adler32-zlib) [ 1577.759023] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 1578.019977] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 1579.735728] Key type lgssc registered [ 1581.169430] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1636.174384] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1641.578681] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1663.219674] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1665.949932] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 1672.874547] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1676.303690] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1687.972114] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-2115h20m37s [ 1690.016797] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1696.741141] Lustre: lustre-MDT0000-mdc-ffff8abf435c7800: Connection to lustre-MDT0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1700.821337] LustreError: 36728:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8abf435c7800: can't stat MDS #0: rc = -19 [ 1702.745548] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1715.174733] LustreError: MGC192.168.202.139@tcp: Connection to MGS (at 192.168.202.139@tcp) was lost; in progress operations using this service will fail [ 1715.191180] Lustre: Evicted from MGS (at 192.168.202.139@tcp) after server handle changed from 0xa1e5fec6ca2ef900 to 0xa1e5fec6ca2efbca [ 1715.199305] Lustre: MGC192.168.202.139@tcp: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [ 1716.284989] LustreError: lustre-MDT0000-mdc-ffff8abf435c7800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1716.313820] Lustre: lustre-MDT0000-mdc-ffff8abf435c7800: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [ 1725.597745] Lustre: DEBUG MARKER: Wait for df (36728) ... [ 1728.352817] Lustre: DEBUG MARKER: done [ 1732.932328] Lustre: Unmounted lustre-client [ 1772.769803] Key type lgssc unregistered [ 1773.158383] LNet: 37751:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1773.174174] LNetError: 37751:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1773.194557] LNet: Removed LNI 192.168.202.39@tcp [ 1774.104169] Key type .llcrypt unregistered [ 1774.105856] Key type ._llcrypt unregistered [ 1802.832447] Key type ._llcrypt registered [ 1802.838934] Key type .llcrypt registered [ 1804.459148] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 15:22:33 (1787340153) [ 1807.809471] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1807.840140] alg: No test for adler32 (adler32-zlib) [ 1809.144161] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 1809.400256] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 1811.087430] Key type lgssc registered [ 1812.598131] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1862.189427] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1867.779185] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1889.881458] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1892.677904] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 1898.017638] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-2115h24m06s [ 1899.941423] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1908.433365] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1911.254840] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1931.744230] Lustre: 41898:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787340261/real 1787340261] req@00000000e7e5945e x1874161995619072/t0(0) o101->lustre-MDT0000-mdc-ffff8abf4483a000@192.168.202.139@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787340281 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1931.795133] Lustre: lustre-MDT0000-mdc-ffff8abf4483a000: Connection to lustre-MDT0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1931.852144] Lustre: lustre-MDT0000-mdc-ffff8abf4483a000: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [ 1953.260461] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1956.880050] Lustre: DEBUG MARKER: done [ 1960.701265] Lustre: Unmounted lustre-client [ 1985.690438] Key type lgssc unregistered [ 1985.989124] LNet: 42787:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1985.994870] LNetError: 42787:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1986.010697] LNet: Removed LNI 192.168.202.39@tcp [ 1986.655372] Key type .llcrypt unregistered [ 1986.656490] Key type ._llcrypt unregistered [ 2018.802792] Key type ._llcrypt registered [ 2018.803937] Key type .llcrypt registered [ 2020.497944] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 15:26:09 (1787340369) [ 2022.170462] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2024.177244] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 15:26:13 (1787340373) [ 2028.156611] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2028.212889] alg: No test for adler32 (adler32-zlib) [ 2029.221867] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 2029.428412] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 2031.111237] Key type lgssc registered [ 2032.772687] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2071.064351] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 15:26:59 (1787340419) [ 2109.367455] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2114.796753] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2135.321578] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2138.120562] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 2141.716425] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2145.396752] Lustre: Unmounted lustre-client [ 2162.461159] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2215.530385] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2222.130867] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2222.761814] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 2226.990535] Lustre: Unmounted lustre-client [ 2298.859556] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2305.767213] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2306.392564] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 2310.511372] Lustre: Unmounted lustre-client [ 2333.700724] Lustre: DEBUG MARKER: files compared the same [ 2347.771411] Key type lgssc unregistered [ 2348.178762] LNet: 50414:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2348.188469] LNetError: 50414:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2349.225910] LNet: Removed LNI 192.168.202.39@tcp [ 2350.137515] Key type .llcrypt unregistered [ 2350.140188] Key type ._llcrypt unregistered [ 2368.641915] Key type ._llcrypt registered [ 2368.648521] Key type .llcrypt registered [ 2370.358076] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 15:31:59 (1787340719) [ 2373.202175] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2373.276657] alg: No test for adler32 (adler32-zlib) [ 2374.478945] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 2374.845668] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 2376.647239] Key type lgssc registered [ 2378.361712] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2434.952396] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2442.059769] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2466.373177] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2468.856320] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 2472.698950] Lustre: Unmounted lustre-client [ 2500.195490] Key type lgssc unregistered [ 2500.647833] LNet: 54001:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2500.683260] LNetError: 54001:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2500.696295] LNet: Removed LNI 192.168.202.39@tcp [ 2501.444484] Key type .llcrypt unregistered [ 2501.449171] Key type ._llcrypt unregistered [ 2516.485758] Key type ._llcrypt registered [ 2516.489607] Key type .llcrypt registered [ 2518.219607] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 15:34:26 (1787340866) [ 2521.718821] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2521.798994] alg: No test for adler32 (adler32-zlib) [ 2523.127899] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 2523.454750] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 2525.311172] Key type lgssc registered [ 2527.292343] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2612.563259] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2647.309746] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2652.736265] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2679.622568] Key type lgssc unregistered [ 2679.853550] LNet: 57491:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2679.860724] LNetError: 57491:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2679.878432] LNet: Removed LNI 192.168.202.39@tcp [ 2680.576787] Key type .llcrypt unregistered [ 2680.579364] Key type ._llcrypt unregistered [ 2694.273939] Key type ._llcrypt registered [ 2694.275947] Key type .llcrypt registered [ 2695.545408] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 15:37:24 (1787341044) [ 2698.940483] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2698.980253] alg: No test for adler32 (adler32-zlib) [ 2700.107624] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 2700.373812] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 2702.111218] Key type lgssc registered [ 2703.410533] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2782.047274] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 2790.106675] Lustre: Unmounted lustre-client [ 2828.629584] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 15:39:37 (1787341177) [ 2963.585872] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2981.549176] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 2989.456475] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2989.462269] LustreError: 63961:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8abf44290800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2989.482420] Lustre: 58476:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.139@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2999.844299] Lustre: Unmounted lustre-client [ 3055.711504] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 15:43:24 (1787341404) [ 3067.799724] Key type lgssc unregistered [ 3067.977313] LNet: 65177:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3067.982840] LNetError: 65177:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3067.997199] LNet: Removed LNI 192.168.202.39@tcp [ 3068.631494] Key type .llcrypt unregistered [ 3068.635358] Key type ._llcrypt unregistered [ 3082.202769] Key type ._llcrypt registered [ 3082.211708] Key type .llcrypt registered [ 3082.880816] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3082.923346] alg: No test for adler32 (adler32-zlib) [ 3084.321360] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 3084.811353] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 3086.546179] Key type lgssc registered [ 3087.931585] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3141.586627] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3148.519352] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3170.476682] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3172.301506] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 3179.808436] Lustre: Unmounted lustre-client [ 3207.887803] Key type lgssc unregistered [ 3208.144199] LNet: 68193:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3208.152250] LNetError: 68193:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3208.170586] LNet: Removed LNI 192.168.202.39@tcp [ 3208.983867] Key type .llcrypt unregistered [ 3208.990388] Key type ._llcrypt unregistered [ 3220.026750] Key type ._llcrypt registered [ 3220.054577] Key type .llcrypt registered [ 3220.591862] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3220.604464] alg: No test for adler32 (adler32-zlib) [ 3221.809054] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 3222.031936] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 3223.703393] Key type lgssc registered [ 3225.372086] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3348.001287] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3353.508944] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3374.747949] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3376.551832] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 3384.575247] Lustre: Unmounted lustre-client [ 3421.374633] Key type lgssc unregistered [ 3421.743840] LNet: 71630:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3421.754094] LNetError: 71630:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3421.769160] LNet: Removed LNI 192.168.202.39@tcp [ 3422.663522] Key type .llcrypt unregistered [ 3422.666628] Key type ._llcrypt unregistered [ 3441.223724] Key type ._llcrypt registered [ 3441.225392] Key type .llcrypt registered [ 3442.685455] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 15:49:51 (1787341791) [ 3446.036909] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3446.065457] alg: No test for adler32 (adler32-zlib) [ 3447.344517] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 3447.664662] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 3449.359216] Key type lgssc registered [ 3451.259748] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3500.932555] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3506.130227] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3527.522766] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3530.241320] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 3535.778223] Lustre: Unmounted lustre-client [ 3536.317851] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 3539.362877] Lustre: Unmounted lustre-client [ 3577.824674] Key type lgssc unregistered [ 3578.166781] LNet: 75324:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3578.186570] LNetError: 75324:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3578.221163] LNet: Removed LNI 192.168.202.39@tcp [ 3579.119202] Key type .llcrypt unregistered [ 3579.121095] Key type ._llcrypt unregistered [ 3591.593850] Key type ._llcrypt registered [ 3591.597965] Key type .llcrypt registered [ 3592.099653] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3592.147728] alg: No test for adler32 (adler32-zlib) [ 3593.331529] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 3593.587960] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 3595.311244] Key type lgssc registered [ 3596.568564] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3645.666382] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3650.987639] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3675.566404] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3677.458391] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 3682.731227] Lustre: Unmounted lustre-client [ 3711.659860] Key type lgssc unregistered [ 3711.935224] LNet: 78358:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3711.938621] LNetError: 78358:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3711.961534] LNet: Removed LNI 192.168.202.39@tcp [ 3712.879407] Key type .llcrypt unregistered [ 3712.881758] Key type ._llcrypt unregistered [ 3726.714533] Key type ._llcrypt registered [ 3726.717690] Key type .llcrypt registered [ 3728.459420] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 15:54:37 (1787342077) [ 3731.483269] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3731.557278] alg: No test for adler32 (adler32-zlib) [ 3732.885918] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 3733.199648] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 3734.880540] Key type lgssc registered [ 3736.037732] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3789.283348] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3796.241774] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3821.066301] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3823.862880] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 3831.348773] Lustre: lustre: root_squash is set to 0:0 [ 3840.559483] Lustre: lustre: nosquash_nids is cleared [ 3840.585922] Lustre: lustre: root_squash is set to 500:500 [ 3852.859617] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.39@tcp 192.168.0.[2,10]@tcp [ 3860.527894] Lustre: lustre: nosquash_nids set to 192.168.202.39/24@tcp [ 3865.775743] Lustre: Unmounted lustre-client [ 3899.744590] Key type lgssc unregistered [ 3900.210708] LNet: 82289:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3900.222110] LNetError: 82289:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3900.239179] LNet: Removed LNI 192.168.202.39@tcp [ 3901.579582] Key type .llcrypt unregistered [ 3901.581107] Key type ._llcrypt unregistered [ 3924.937470] Key type ._llcrypt registered [ 3924.939611] Key type .llcrypt registered [ 3927.073753] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 15:57:55 (1787342275) [ 3930.663704] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3933.802789] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 15:58:01 (1787342281) [ 3936.553223] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3936.617396] alg: No test for adler32 (adler32-zlib) [ 3937.806102] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 3938.079083] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 3939.791225] Key type lgssc registered [ 3941.565395] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4000.341658] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4008.972819] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4037.995597] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4039.604742] Lustre: lustre: root_squash is set to 500:500 [ 4039.637836] Lustre: lustre: nosquash_nids set to 192.168.202.39/24@tcp [ 4040.781558] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 4047.318731] Lustre: Unmounted lustre-client [ 4081.643880] Key type lgssc unregistered [ 4082.075340] LNet: 86267:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4082.083801] LNetError: 86267:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4082.098812] LNet: Removed LNI 192.168.202.39@tcp [ 4083.121349] Key type .llcrypt unregistered [ 4083.124320] Key type ._llcrypt unregistered [ 4102.823903] Key type ._llcrypt registered [ 4102.831960] Key type .llcrypt registered [ 4105.037676] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4106.896581] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 16:00:55 (1787342455) [ 4126.922398] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4127.138854] alg: No test for adler32 (adler32-zlib) [ 4128.443976] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 4128.848158] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 4130.671345] Key type lgssc registered [ 4132.481942] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4244.998634] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4251.713853] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4278.475406] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4351.662469] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4359.220718] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4382.932873] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4397.935534] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 4434.837912] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8abf52e21800.ost_server_uuid 50 [ 4436.433053] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8abf52e21800.ost_server_uuid in FULL state after 0 sec [ 4437.060808] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 4440.934227] Lustre: Unmounted lustre-client [ 4443.134253] Lustre: Unmounted lustre-client [ 4495.384474] Key type lgssc unregistered [ 4495.761835] LNet: 93958:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4495.772286] LNetError: 93958:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4496.816287] LNet: Removed LNI 192.168.202.39@tcp [ 4497.727894] Key type .llcrypt unregistered [ 4497.732364] Key type ._llcrypt unregistered [ 4530.714484] Key type ._llcrypt registered [ 4530.716490] Key type .llcrypt registered [ 4532.157564] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 16:08:01 (1787342881) [ 4552.430725] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4552.475242] alg: No test for adler32 (adler32-zlib) [ 4553.640356] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 4553.915239] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 4555.615782] Key type lgssc registered [ 4556.812425] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4643.470684] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4650.204313] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4674.461148] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4676.486111] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 4698.147188] Lustre: 95320:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787343032/real 1787343032] req@0000000039a2e2d7 x1874164872909952/t0(0) o400->lustre-OST0000-osc-ffff8abf50980800@192.168.202.139@tcp:28/4 lens 224/224 e 0 to 1 dl 1787343048 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4698.190478] Lustre: lustre-OST0000-osc-ffff8abf50980800: Connection to lustre-OST0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4702.687250] Lustre: 95321:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787343037/real 1787343037] req@00000000cd15d945 x1874164872910464/t0(0) o400->lustre-OST0000-osc-ffff8abf50980800@192.168.202.139@tcp:28/4 lens 224/224 e 0 to 1 dl 1787343053 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4707.809065] Lustre: 95320:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787343042/real 1787343042] req@0000000093cf7ed7 x1874164872910976/t0(0) o400->lustre-OST0000-osc-ffff8abf50980800@192.168.202.139@tcp:28/4 lens 224/224 e 0 to 1 dl 1787343058 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4708.901368] Lustre: lustre-OST0000-osc-ffff8abf50980800: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [ 4712.965345] Lustre: lustre-MDT0000-mdc-ffff8abf50980800: Connection to lustre-MDT0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4713.953405] Lustre: 95320:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787343047/real 1787343047] req@00000000b2755fd7 x1874164872911488/t0(0) o400->lustre-OST0000-osc-ffff8abf50980800@192.168.202.139@tcp:28/4 lens 224/224 e 0 to 1 dl 1787343063 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4729.311549] Lustre: 95321:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787343063/real 1787343063] req@00000000cd15d945 x1874164872913792/t0(0) o400->MGC192.168.202.139@tcp@192.168.202.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1787343079 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4729.364213] LustreError: MGC192.168.202.139@tcp: Connection to MGS (at 192.168.202.139@tcp) was lost; in progress operations using this service will fail [ 4739.586952] Lustre: Evicted from MGS (at 192.168.202.139@tcp) after server handle changed from 0x72ccc1330bd2cb44 to 0x72ccc1330bd2cdd6 [ 4739.602971] Lustre: MGC192.168.202.139@tcp: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [ 4744.480191] Lustre: lustre-MDT0000-mdc-ffff8abf50980800: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [ 4752.870326] Lustre: Unmounted lustre-client [ 4788.679717] Key type lgssc unregistered [ 4789.073980] LNet: 99627:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4789.080420] LNetError: 99627:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4789.106548] LNet: Removed LNI 192.168.202.39@tcp [ 4790.037671] Key type .llcrypt unregistered [ 4790.039366] Key type ._llcrypt unregistered [ 4805.564314] Key type ._llcrypt registered [ 4805.571597] Key type .llcrypt registered [ 4806.673327] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 16:12:35 (1787343155) [ 4821.827051] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4821.851391] alg: No test for adler32 (adler32-zlib) [ 4822.920791] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 4823.150460] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 4824.935214] Key type lgssc registered [ 4826.540218] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4867.012243] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4971.463972] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4978.996595] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5009.556686] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5011.621786] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 5013.545457] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5015.947800] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 16:16:04 (1787343364) [ 5256.166379] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5266.561607] Lustre: Unmounted lustre-client [ 5407.757218] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5416.281583] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5441.125172] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5485.291654] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 16:23:54 (1787343834) [ 5578.048891] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5583.490237] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5609.686598] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5610.733100] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 5617.461873] Lustre: Unmounted lustre-client [ 5660.018513] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 16:26:48 (1787344008) [ 5756.426120] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5762.371538] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5785.428151] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5786.143687] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 5790.451401] Lustre: Unmounted lustre-client [ 5824.420722] Key type lgssc unregistered [ 5824.715659] LNet: 122662:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5824.719956] LNetError: 122662:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5824.731733] LNet: Removed LNI 192.168.202.39@tcp [ 5825.355741] Key type .llcrypt unregistered [ 5825.358686] Key type ._llcrypt unregistered [ 5840.536745] Key type ._llcrypt registered [ 5840.539646] Key type .llcrypt registered [ 5842.349337] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 16:29:50 (1787344190) [ 5845.145317] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5845.388357] alg: No test for adler32 (adler32-zlib) [ 5846.539831] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 5846.794182] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 5848.463421] Key type lgssc registered [ 5850.674480] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5908.782370] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5916.175217] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5939.458428] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5951.551296] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 5964.573914] Lustre: Unmounted lustre-client [ 5994.204694] Key type lgssc unregistered [ 5994.498462] LNet: 126265:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5994.508445] LNetError: 126265:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5994.524793] LNet: Removed LNI 192.168.202.39@tcp [ 5995.399300] Key type .llcrypt unregistered [ 5995.401294] Key type ._llcrypt unregistered [ 6015.863164] Key type ._llcrypt registered [ 6015.869695] Key type .llcrypt registered [ 6017.823295] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 16:32:46 (1787344366) [ 6020.196000] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6020.214817] alg: No test for adler32 (adler32-zlib) [ 6021.299314] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 6021.510911] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 6023.191364] Key type lgssc registered [ 6024.524504] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6083.669218] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6091.593927] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6115.594632] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6126.678554] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 6131.687775] Lustre: lustre-OST0000-osc-ffff8abf4377e800: Connection to lustre-OST0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6148.533390] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8abf4377e800.ost_server_uuid 50 [ 6150.811742] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6163.428610] Lustre: Unmounted lustre-client [ 6191.015750] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 16:35:38 (1787344538) [ 6227.006703] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6233.096778] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6254.109118] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6278.050651] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6278.914163] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 6284.270303] Lustre: lustre-OST0000-osc-ffff8abf46dc1000: Connection to lustre-OST0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6312.213151] Lustre: Unmounted lustre-client [ 6362.600826] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 16:38:31 (1787344711) [ 6402.380222] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6409.047963] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6432.351349] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6455.165673] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6455.989715] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 6461.433116] Lustre: lustre-OST0000-osc-ffff8abf604a0800: Connection to lustre-OST0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6478.333633] Lustre: Unmounted lustre-client [ 6530.846932] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 16:41:19 (1787344879) [ 6634.972617] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6641.723410] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6665.036677] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6739.433194] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6747.064506] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6771.589745] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6813.362167] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 6854.473285] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6859.268653] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 6861.350219] Lustre: Unmounted lustre-client [ 6896.455730] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 16:47:25 (1787345245) [ 6933.660751] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6940.272416] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6963.266417] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6995.759579] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7027.468298] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 7072.399221] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7074.423894] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7086.538869] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7096.930980] Lustre: Unmounted lustre-client [ 7160.019812] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 16:51:48 (1787345508) [ 7196.277962] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7202.625694] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7225.691391] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7226.948432] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 7254.223623] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7256.207258] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7273.603902] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8abf435c4800.ost_server_uuid 50 [ 7275.492885] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8abf435c4800.ost_server_uuid in IDLE state after 0 sec [ 7280.547058] Lustre: Unmounted lustre-client [ 7280.941973] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7280.952247] Lustre: Skipped 3 previous similar messages [ 7281.088394] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 7282.412704] LustreError: 149728:0:(sec.c:403:import_sec_validate_get()) import 000000005346e2df (NEW) with no sec [ 7340.529582] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 16:54:49 (1787345689) [ 7378.335221] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7387.327419] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7408.813726] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7435.648804] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7435.976484] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7436.144770] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 7451.117470] Lustre: Unmounted lustre-client [ 7451.119423] Lustre: Skipped 1 previous similar message [ 7509.389964] Key type lgssc unregistered [ 7509.619716] LNet: 153168:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7509.622945] LNetError: 153168:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7509.644674] LNet: Removed LNI 192.168.202.39@tcp [ 7510.364968] Key type .llcrypt unregistered [ 7510.370829] Key type ._llcrypt unregistered [ 7529.875946] Key type ._llcrypt registered [ 7529.876889] Key type .llcrypt registered [ 7530.954482] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 16:58:00 (1787345880) [ 7532.114720] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7532.126032] alg: No test for adler32 (adler32-zlib) [ 7533.167976] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 7533.506055] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 7535.175180] Key type lgssc registered [ 7536.450437] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7591.214374] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7596.791421] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7618.469808] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7641.799680] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7642.593074] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7643.842051] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 7649.841959] LustreError: lustre-MDT0001-mdc-ffff8abf482c7800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7649.873773] Lustre: lustre-MDT0001-mdc-ffff8abf482c7800: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [ 7657.776229] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7659.750859] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7686.172069] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7690.797565] Lustre: Unmounted lustre-client [ 7719.208889] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 17:01:07 (1787346067) [ 7832.077562] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7839.589841] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7867.936308] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7868.869499] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 7900.517232] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7902.660783] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7916.493129] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7926.908229] Lustre: Unmounted lustre-client [ 7963.762767] Key type lgssc unregistered [ 7964.040745] LNet: 162796:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7964.064447] LNetError: 162796:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7965.098565] LNet: Removed LNI 192.168.202.39@tcp [ 7966.236636] Key type .llcrypt unregistered [ 7966.242521] Key type ._llcrypt unregistered [ 8000.303594] Key type ._llcrypt registered [ 8000.313960] Key type .llcrypt registered [ 8001.780794] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 17:05:50 (1787346350) [ 8004.258224] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8004.277707] alg: No test for adler32 (adler32-zlib) [ 8005.449337] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 8005.746770] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 8007.504159] Key type lgssc registered [ 8009.301378] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8076.567820] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8085.268558] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8114.646342] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8116.647947] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 8167.069288] Lustre: Unmounted lustre-client [ 8217.654618] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8218.484400] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 8257.943021] Lustre: Unmounted lustre-client [ 8290.862470] Key type lgssc unregistered [ 8291.148587] LNet: 167254:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8291.156373] LNetError: 167254:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8291.185421] LNet: Removed LNI 192.168.202.39@tcp [ 8292.428343] Key type .llcrypt unregistered [ 8292.431711] Key type ._llcrypt unregistered [ 8315.755523] Key type ._llcrypt registered [ 8315.757804] Key type .llcrypt registered [ 8318.197886] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 17:11:06 (1787346666) [ 8321.788496] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8321.998324] alg: No test for adler32 (adler32-zlib) [ 8323.333505] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 8323.677705] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 8325.495231] Key type lgssc registered [ 8327.391539] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8385.814044] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8393.773653] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8421.611117] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8424.034871] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 8450.065026] Lustre: Unmounted lustre-client [ 8482.295724] Key type lgssc unregistered [ 8482.703894] LNet: 171019:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8482.708874] LNetError: 171019:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8482.724970] LNet: Removed LNI 192.168.202.39@tcp [ 8483.484227] Key type .llcrypt unregistered [ 8483.485980] Key type ._llcrypt unregistered [ 8501.180128] Key type ._llcrypt registered [ 8501.187569] Key type .llcrypt registered [ 8501.384359] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8501.394561] alg: No test for adler32 (adler32-zlib) [ 8502.397741] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 8502.574360] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 8504.287230] Key type lgssc registered [ 8505.195482] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8560.049832] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8566.584430] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8591.175076] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8602.208231] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 8609.995742] Lustre: Unmounted lustre-client [ 8635.584637] Key type lgssc unregistered [ 8635.935394] LNet: 174089:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8635.947245] LNetError: 174089:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8635.965102] LNet: Removed LNI 192.168.202.39@tcp [ 8636.779816] Key type .llcrypt unregistered [ 8636.781633] Key type ._llcrypt unregistered [ 8653.118466] Key type ._llcrypt registered [ 8653.121996] Key type .llcrypt registered [ 8654.384778] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 17:16:43 (1787347003) [ 8656.854356] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8656.879131] alg: No test for adler32 (adler32-zlib) [ 8658.011334] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 8658.320914] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 8660.047213] Key type lgssc registered [ 8661.834366] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8719.519303] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8727.782576] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8753.448747] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8764.482989] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 8787.147696] Lustre: Unmounted lustre-client [ 8817.345472] Key type lgssc unregistered [ 8817.735692] LNet: 177843:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8817.755921] LNetError: 177843:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8817.776662] LNet: Removed LNI 192.168.202.39@tcp [ 8818.507862] Key type .llcrypt unregistered [ 8818.509628] Key type ._llcrypt unregistered [ 8833.690764] Key type ._llcrypt registered [ 8833.701334] Key type .llcrypt registered [ 8834.679435] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8834.694628] alg: No test for adler32 (adler32-zlib) [ 8835.770731] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 8836.003994] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 8837.703283] Key type lgssc registered [ 8839.479210] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8900.585504] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8907.467145] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8940.583374] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8943.524141] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 8954.535397] Lustre: Unmounted lustre-client [ 8993.613259] Key type lgssc unregistered [ 8994.057182] LNet: 180914:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8994.071827] LNetError: 180914:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8994.107839] LNet: Removed LNI 192.168.202.39@tcp [ 8995.082288] Key type .llcrypt unregistered [ 8995.086351] Key type ._llcrypt unregistered [ 9019.808985] Key type ._llcrypt registered [ 9019.813961] Key type .llcrypt registered [ 9021.318333] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 17:22:50 (1787347370) [ 9052.643763] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9052.670878] alg: No test for adler32 (adler32-zlib) [ 9054.075589] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 9054.443442] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 9056.239197] Key type lgssc registered [ 9058.784379] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9167.134651] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9174.804087] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9203.135817] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9255.948953] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 17:26:45 (1787347605) [ 9308.578981] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9316.327947] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9340.779788] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9342.652714] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 9350.626461] Lustre: Unmounted lustre-client [ 9385.080581] Key type lgssc unregistered [ 9385.433547] LNet: 188030:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9385.453215] LNetError: 188030:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9386.480843] LNet: Removed LNI 192.168.202.39@tcp [ 9387.743982] Key type .llcrypt unregistered [ 9387.749487] Key type ._llcrypt unregistered [ 9409.870504] Key type ._llcrypt registered [ 9409.873906] Key type .llcrypt registered [ 9412.244816] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9414.990972] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 17:29:23 (1787347763) [ 9435.584130] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9435.657475] alg: No test for adler32 (adler32-zlib) [ 9436.910124] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [ 9437.381447] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [ 9439.167206] Key type lgssc registered [ 9440.881238] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9560.184076] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9567.581137] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9596.718647] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9626.748763] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9628.757762] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [ 9663.943146] Lustre: Unmounted lustre-client [ 9829.680726] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9837.919745] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9870.394391] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9927.162738] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 17:37:56 (1787348276) [ 9929.615924] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9932.168475] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 17:38:01 (1787348281) [10058.897858] Key type lgssc unregistered [10059.261071] LNet: 199490:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10059.285941] LNetError: 199490:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10059.325816] LNet: Removed LNI 192.168.202.39@tcp [10060.867750] Key type .llcrypt unregistered [10060.871747] Key type ._llcrypt unregistered [10081.889790] Key type ._llcrypt registered [10081.892933] Key type .llcrypt registered [10083.769881] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 17:40:32 (1787348432) [10132.124751] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10132.183986] alg: No test for adler32 (adler32-zlib) [10133.637323] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [10134.183501] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [10136.060262] Key type lgssc registered [10137.542955] Lustre: Echo OBD driver; http://www.lustre.org/ [10195.317344] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10201.373664] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10237.242411] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10273.311555] Key type lgssc unregistered [10273.538634] LNet: 203232:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10273.546521] LNetError: 203232:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10273.568822] LNet: Removed LNI 192.168.202.39@tcp [10274.284933] Key type .llcrypt unregistered [10274.292553] Key type ._llcrypt unregistered [10292.430121] Key type ._llcrypt registered [10292.431559] Key type .llcrypt registered [10293.958349] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 17:44:02 (1787348642) [10298.350138] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10298.382192] alg: No test for adler32 (adler32-zlib) [10299.618864] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [10300.020886] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [10301.903877] Key type lgssc registered [10304.212850] Lustre: Echo OBD driver; http://www.lustre.org/ [10378.627830] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10386.044623] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10413.860814] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10415.711349] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [10425.846991] Lustre: lustre-MDT0000-mdc-ffff8abf50986800: Connection to lustre-MDT0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [10436.075591] Lustre: lustre-MDT0001-mdc-ffff8abf50986800: Connection to lustre-MDT0001 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [10447.327747] Lustre: 204241:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787348781/real 1787348781] req@000000005c994eb1 x1874170898104192/t0(0) o400->MGC192.168.202.139@tcp@192.168.202.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1787348797 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10447.369501] LustreError: MGC192.168.202.139@tcp: Connection to MGS (at 192.168.202.139@tcp) was lost; in progress operations using this service will fail [10472.934708] Lustre: Evicted from MGS (at 192.168.202.139@tcp) after server handle changed from 0x18e5c79ab3cc4360 to 0x18e5c79ab3cc5ca4 [10472.976574] Lustre: MGC192.168.202.139@tcp: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [10510.876687] LustreError: lustre-MDT0000-mdc-ffff8abf50986800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10510.914406] Lustre: lustre-MDT0000-mdc-ffff8abf50986800: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [10515.425845] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10517.760727] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10524.416724] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10526.553975] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10530.208691] Lustre: Unmounted lustre-client [10564.239605] Key type lgssc unregistered [10564.794419] LNet: 208207:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10564.816392] LNetError: 208207:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10564.846426] LNet: Removed LNI 192.168.202.39@tcp [10566.134382] Key type .llcrypt unregistered [10566.136786] Key type ._llcrypt unregistered [10589.865459] Key type ._llcrypt registered [10589.868512] Key type .llcrypt registered [10591.170975] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 17:49:00 (1787348940) [10594.441339] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10594.606160] alg: No test for adler32 (adler32-zlib) [10595.882392] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [10596.245988] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [10598.040059] Key type lgssc registered [10599.735200] Lustre: Echo OBD driver; http://www.lustre.org/ [10661.552494] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10667.949783] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10728.184543] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10734.307860] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10775.535528] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10808.804777] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10868.053268] Key type lgssc unregistered [10868.337367] LNet: 213514:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10868.346892] LNetError: 213514:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10868.390618] LNet: Removed LNI 192.168.202.39@tcp [10869.512299] Key type .llcrypt unregistered [10869.516257] Key type ._llcrypt unregistered [10926.404351] Key type ._llcrypt registered [10926.405864] Key type .llcrypt registered [10927.881625] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 17:54:36 (1787349276) [10968.109912] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10968.140698] alg: No test for adler32 (adler32-zlib) [10969.243865] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [10969.480297] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [10971.216891] Key type lgssc registered [10972.653717] Lustre: Echo OBD driver; http://www.lustre.org/ [11068.271614] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11074.641087] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11099.432495] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11147.305622] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 17:58:16 (1787349496) [11155.427343] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 17:58:24 (1787349504) [11191.019768] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11197.751922] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11222.037724] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11223.714591] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [11232.670623] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [11236.017262] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [11237.895941] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [11240.226370] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [11244.015314] Lustre: lustre-MDT0000-mdc-ffff8abf50568000: Connection to lustre-MDT0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [11260.321085] Lustre: 215416:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787349594/real 1787349594] req@00000000590787d1 x1874171600578688/t0(0) o400->MGC192.168.202.139@tcp@192.168.202.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1787349610 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11260.349360] LustreError: MGC192.168.202.139@tcp: Connection to MGS (at 192.168.202.139@tcp) was lost; in progress operations using this service will fail [11270.640491] Lustre: Evicted from MGS (at 192.168.202.139@tcp) after server handle changed from 0xd9957644696daa92 to 0xd9957644696dacbb [11270.658030] Lustre: MGC192.168.202.139@tcp: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [11276.133808] Lustre: lustre-MDT0000-mdc-ffff8abf50568000: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [11285.597418] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11287.723903] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11291.486983] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [11296.251173] Lustre: lustre-MDT0000-mdc-ffff8abf50568000: Connection to lustre-MDT0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [11311.455546] Lustre: 215415:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787349646/real 1787349646] req@00000000724d08d8 x1874171600588032/t0(0) o400->MGC192.168.202.139@tcp@192.168.202.139@tcp:26/25 lens 224/224 e 0 to 1 dl 1787349662 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11311.479873] LustreError: MGC192.168.202.139@tcp: Connection to MGS (at 192.168.202.139@tcp) was lost; in progress operations using this service will fail [11321.838745] Lustre: Evicted from MGS (at 192.168.202.139@tcp) after server handle changed from 0xd9957644696dacbb to 0xd9957644696daf1c [11321.861912] Lustre: MGC192.168.202.139@tcp: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [11328.832400] Lustre: lustre-MDT0000-mdc-ffff8abf50568000: Connection restored to 192.168.202.139@tcp (at 192.168.202.139@tcp) [11338.998811] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11340.881517] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11344.696425] Lustre: Unmounted lustre-client [11421.905710] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11428.163310] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11450.825459] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11462.219467] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [11465.164810] Lustre: Unmounted lustre-client [11496.499430] Key type lgssc unregistered [11496.899258] LNet: 226024:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11496.906601] LNetError: 226024:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11496.923736] LNet: Removed LNI 192.168.202.39@tcp [11498.120891] Key type .llcrypt unregistered [11498.124133] Key type ._llcrypt unregistered [11516.240930] Key type ._llcrypt registered [11516.249162] Key type .llcrypt registered [11517.922096] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 18:04:26 (1787349866) [11523.324156] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11523.378111] alg: No test for adler32 (adler32-zlib) [11524.480398] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [11524.685790] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [11526.343273] Key type lgssc registered [11527.468879] Lustre: Echo OBD driver; http://www.lustre.org/ [11577.241419] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11586.112451] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11615.788896] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11622.952176] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [11630.156491] Lustre: Unmounted lustre-client [11711.040125] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11719.785430] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11744.029986] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11750.465136] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [11760.252137] Lustre: Unmounted lustre-client [11848.040281] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11855.139697] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11885.009922] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11885.647562] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [11888.498712] Lustre: Unmounted lustre-client [11918.756391] Key type lgssc unregistered [11919.103610] LNet: 233092:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11919.116199] LNetError: 233092:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11919.137327] LNet: Removed LNI 192.168.202.39@tcp [11919.950158] Key type .llcrypt unregistered [11919.952035] Key type ._llcrypt unregistered [11937.905700] Key type ._llcrypt registered [11937.910408] Key type .llcrypt registered [11939.489500] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 18:11:28 (1787350288) [11943.631412] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11943.790733] alg: No test for adler32 (adler32-zlib) [11944.955839] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [11945.222664] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [11947.015260] Key type lgssc registered [11948.495996] Lustre: Echo OBD driver; http://www.lustre.org/ [11998.780324] Key type lgssc unregistered [11999.094722] LNet: 235421:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11999.105400] LNetError: 235421:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11999.121645] LNet: Removed LNI 192.168.202.39@tcp [11999.878604] Key type .llcrypt unregistered [11999.883846] Key type ._llcrypt unregistered [12032.522390] Key type ._llcrypt registered [12032.523491] Key type .llcrypt registered [12032.861616] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12032.882139] alg: No test for adler32 (adler32-zlib) [12034.128807] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [12034.420225] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [12036.199186] Key type lgssc registered [12037.927392] Lustre: Echo OBD driver; http://www.lustre.org/ [12132.609635] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12138.561483] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12165.931248] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12217.783644] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [12219.819935] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 18:16:08 (1787350568) [12259.166660] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12266.081455] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12292.396602] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12321.274914] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12323.204300] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [12328.454220] Lustre: lustre-OST0001-osc-ffff8abf50980800: Connection to lustre-OST0001 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [12335.979358] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12346.392362] Lustre: Unmounted lustre-client [12391.087945] Key type lgssc unregistered [12391.388855] LNet: 242552:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12391.394732] LNetError: 242552:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12391.416516] LNet: Removed LNI 192.168.202.39@tcp [12391.972380] Key type .llcrypt unregistered [12391.974837] Key type ._llcrypt unregistered [12430.959638] Key type ._llcrypt registered [12430.961753] Key type .llcrypt registered [12432.618494] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 18:19:41 (1787350781) [12449.170766] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12449.399400] alg: No test for adler32 (adler32-zlib) [12450.639670] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [12450.923647] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [12452.824090] Key type lgssc registered [12454.167511] Lustre: Echo OBD driver; http://www.lustre.org/ [12520.271642] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12528.701707] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12554.569619] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 18:21:43 (1787350903) [12600.701297] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12608.753466] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12637.351421] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12640.328512] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [12649.245485] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12661.483269] Lustre: Unmounted lustre-client [12782.606953] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12792.424514] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12856.221365] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12857.169128] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [12858.585047] Lustre: Unmounted lustre-client [12886.633543] Key type lgssc unregistered [12887.030305] LNet: 250259:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12887.055657] LNetError: 250259:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12887.082309] LNet: Removed LNI 192.168.202.39@tcp [12888.098738] Key type .llcrypt unregistered [12888.101907] Key type ._llcrypt unregistered [12926.285146] Key type ._llcrypt registered [12926.299139] Key type .llcrypt registered [12926.889342] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12926.898765] alg: No test for adler32 (adler32-zlib) [12928.211662] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [12928.663514] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [12930.487220] Key type lgssc registered [12932.106971] Lustre: Echo OBD driver; http://www.lustre.org/ [13026.660539] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13034.619399] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13064.057196] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13114.831803] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [13117.223975] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 18:31:05 (1787351465) [13156.488677] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13163.826710] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13191.572588] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13196.731753] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [13200.776037] Lustre: Unmounted lustre-client [13230.597413] Key type lgssc unregistered [13230.853956] LNet: 256912:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13230.861885] LNetError: 256912:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13230.879094] LNet: Removed LNI 192.168.202.39@tcp [13232.012519] Key type .llcrypt unregistered [13232.020345] Key type ._llcrypt unregistered [13253.599124] Key type ._llcrypt registered [13253.607527] Key type .llcrypt registered [13255.081194] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [13257.659300] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 18:33:26 (1787351606) [13268.873573] Key type .llcrypt unregistered [13268.876866] Key type ._llcrypt unregistered [13280.750358] Key type ._llcrypt registered [13280.754636] Key type .llcrypt registered [13281.520653] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13281.572282] alg: No test for adler32 (adler32-zlib) [13282.679342] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [13282.989781] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [13284.871309] Key type lgssc registered [13286.326303] Lustre: Echo OBD driver; http://www.lustre.org/ [13343.312898] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13363.410428] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [13367.194211] Lustre: Unmounted lustre-client [13386.734774] Key type lgssc unregistered [13387.036537] LNet: 260378:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13387.045943] LNetError: 260378:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13387.074899] LNet: Removed LNI 192.168.202.39@tcp [13388.233292] Key type .llcrypt unregistered [13388.235669] Key type ._llcrypt unregistered [13409.315943] Key type ._llcrypt registered [13409.318059] Key type .llcrypt registered [13411.678499] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 18:35:59 (1787351759) [13415.668865] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13415.693289] alg: No test for adler32 (adler32-zlib) [13416.877486] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [13417.204213] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [13419.063324] Key type lgssc registered [13421.226115] Lustre: Echo OBD driver; http://www.lustre.org/ [13509.701366] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13548.826879] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13555.217535] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13557.954146] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [13560.956157] Lustre: Unmounted lustre-client [13590.681435] Key type lgssc unregistered [13591.148380] LNet: 263927:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13591.154587] LNetError: 263927:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13591.174986] LNet: Removed LNI 192.168.202.39@tcp [13592.042923] Key type .llcrypt unregistered [13592.068320] Key type ._llcrypt unregistered [13612.352956] Key type ._llcrypt registered [13612.355578] Key type .llcrypt registered [13614.029585] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 18:39:22 (1787351962) [13617.672958] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13617.697904] alg: No test for adler32 (adler32-zlib) [13619.065400] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [13619.323818] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [13621.039273] Key type lgssc registered [13623.027527] Lustre: Echo OBD driver; http://www.lustre.org/ [13685.632629] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13692.562936] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13717.811755] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13724.720394] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [13729.776819] Lustre: lustre-MDT0000-mdc-ffff8abf50568800: Connection to lustre-MDT0000 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [13736.182239] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13736.222884] LustreError: 267085:0:(file.c:6166:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13736.740798] LustreError: MGC192.168.202.139@tcp: Connection to MGS (at 192.168.202.139@tcp) was lost; in progress operations using this service will fail [13736.820493] Lustre: Unmounted lustre-client [13758.166588] Key type lgssc unregistered [13758.432799] LNet: 267502:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13758.445650] LNetError: 267502:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13758.472192] LNet: Removed LNI 192.168.202.39@tcp [13759.414603] Key type .llcrypt unregistered [13759.417988] Key type ._llcrypt unregistered [13777.710371] Key type ._llcrypt registered [13777.712487] Key type .llcrypt registered [13779.205421] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 18:42:08 (1787352128) [13783.337183] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13783.377546] alg: No test for adler32 (adler32-zlib) [13784.652601] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [13784.899488] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [13786.657464] Key type lgssc registered [13788.285629] Lustre: Echo OBD driver; http://www.lustre.org/ [13845.185564] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13853.419357] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13877.302513] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13889.613259] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [13894.634370] Lustre: lustre-MDT0001-mdc-ffff8abf590f9000: Connection to lustre-MDT0001 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [13902.194794] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13905.771250] Lustre: Unmounted lustre-client [13929.051548] Key type lgssc unregistered [13929.358904] LNet: 271091:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13929.367283] LNetError: 271091:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13929.385796] LNet: Removed LNI 192.168.202.39@tcp [13930.389764] Key type .llcrypt unregistered [13930.395843] Key type ._llcrypt unregistered [13949.342897] Key type ._llcrypt registered [13949.346868] Key type .llcrypt registered [13950.917643] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 18:44:59 (1787352299) [13971.646069] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13971.767362] alg: No test for adler32 (adler32-zlib) [13972.827361] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [13973.023918] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [13974.671737] Key type lgssc registered [13975.776266] Lustre: Echo OBD driver; http://www.lustre.org/ [14099.637882] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14102.462997] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [14149.115370] Lustre: lustre-MDT0001-mdc-ffff8abf4443c000: Connection to lustre-MDT0001 (at 192.168.202.139@tcp) was lost; in progress operations using this service will wait for recovery to complete [14158.545122] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [14168.866629] Lustre: Unmounted lustre-client [14215.427086] Key type lgssc unregistered [14215.789036] LNet: 276888:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14215.806665] LNetError: 276888:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14215.831405] LNet: Removed LNI 192.168.202.39@tcp [14216.757406] Key type .llcrypt unregistered [14216.761500] Key type ._llcrypt unregistered [14237.635162] Key type ._llcrypt registered [14237.637747] Key type .llcrypt registered [14239.403819] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 18:49:48 (1787352588) [14241.634945] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [14244.005857] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 18:49:52 (1787352592) [14246.357678] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [14248.603757] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 18:49:57 (1787352597) [14250.600772] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [14252.739213] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 18:50:01 (1787352601) [14254.801169] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [14256.536731] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 18:50:05 (1787352605) [14258.560424] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [14260.482220] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 18:50:09 (1787352609) [14270.375592] Key type .llcrypt unregistered [14270.377775] Key type ._llcrypt unregistered [14278.576187] Key type ._llcrypt registered [14278.582325] Key type .llcrypt registered [14279.128230] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14279.137988] alg: No test for adler32 (adler32-zlib) [14280.230270] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [14280.458071] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [14282.191475] Key type lgssc registered [14283.700204] Lustre: Echo OBD driver; http://www.lustre.org/ [14360.761477] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14368.351983] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14395.860750] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14397.587249] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [14399.600784] Lustre: Unmounted lustre-client [14436.329473] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 18:53:05 (1787352785) [14469.876563] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14476.772133] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14511.239371] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14517.310889] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [14519.311771] Lustre: Unmounted lustre-client [14566.138633] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 18:55:15 (1787352915) [14568.225296] LNet: 1 local NIs in recovery (showing 1): 192.168.202.39@tcp [15221.952560] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15228.985630] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15264.317702] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15369.125435] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 19:08:37 (1787353717) [15384.480158] Key type lgssc unregistered [15384.887429] LNet: 290431:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15384.901868] LNetError: 290431:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15384.919327] LNet: Removed LNI 192.168.202.39@tcp [15385.740607] Key type .llcrypt unregistered [15385.745532] Key type ._llcrypt unregistered [15514.324204] Key type ._llcrypt registered [15514.342795] Key type .llcrypt registered [15514.723254] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15514.772645] alg: No test for adler32 (adler32-zlib) [15515.974100] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [15516.287170] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [15518.111828] Key type lgssc registered [15520.329879] Lustre: Echo OBD driver; http://www.lustre.org/ [15613.750192] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15620.957758] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15645.621371] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15684.403662] Key type lgssc unregistered [15684.904091] LNet: 294130:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15684.918419] LNetError: 294130:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15684.956141] LNet: Removed LNI 192.168.202.39@tcp [15686.278270] Key type .llcrypt unregistered [15686.284529] Key type ._llcrypt unregistered [15704.818895] Key type ._llcrypt registered [15704.821677] Key type .llcrypt registered [15706.821354] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 19:14:15 (1787354055) [15731.787252] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15731.924591] alg: No test for adler32 (adler32-zlib) [15733.181770] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [15733.590166] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [15735.343453] Key type lgssc registered [15737.302659] Lustre: Echo OBD driver; http://www.lustre.org/ [15791.863747] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 19:15:40 (1787354140) [15805.680768] Key type lgssc unregistered [15805.973334] LNet: 297686:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15805.982611] LNetError: 297686:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15806.005161] LNet: Removed LNI 192.168.202.39@tcp [15806.868486] Key type .llcrypt unregistered [15806.873287] Key type ._llcrypt unregistered [15820.042950] Key type ._llcrypt registered [15820.052305] Key type .llcrypt registered [15820.848919] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15820.867384] alg: No test for adler32 (adler32-zlib) [15822.069840] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [15822.309787] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [15824.000377] Key type lgssc registered [15825.815750] Lustre: Echo OBD driver; http://www.lustre.org/ [15893.536391] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15900.471769] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15926.034355] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16245.898152] LNet: Added LNI 192.168.202.39@tcp50 [8/256/0/180] [16249.741537] LNet: Removed LNI 192.168.202.39@tcp [16252.302590] Lustre: 302107:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8abf474f3000: config has no valid NIDs, force dynamic NIDs [16253.557367] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [16253.899371] Lustre: Unmounted lustre-client [16257.304983] Key type lgssc unregistered [16257.722485] LNet: 302369:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16257.727887] LNetError: 302369:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16257.741346] LNet: Removed LNI 192.168.202.39@tcp50 [16258.487188] Key type .llcrypt unregistered [16258.503503] Key type ._llcrypt unregistered [16279.404314] Key type ._llcrypt registered [16279.413677] Key type .llcrypt registered [16279.794778] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [16279.810414] alg: No test for adler32 (adler32-zlib) [16281.193651] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [16281.524348] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [16283.207343] Key type lgssc registered [16285.227623] Lustre: Echo OBD driver; http://www.lustre.org/ [16345.445766] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16353.284980] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16363.553129] LNet: Added LNI 192.168.202.39@tcp50 [8/256/0/180] [16364.795290] LNet: Removed LNI 192.168.202.39@tcp [16366.105703] Lustre: 305064:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8abf45228800: config has no valid NIDs, force dynamic NIDs [16367.576733] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [16368.408326] Lustre: Unmounted lustre-client [16409.512869] Key type lgssc unregistered [16409.989274] LNet: 305938:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16410.000457] LNetError: 305938:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16410.020570] LNet: Removed LNI 192.168.202.39@tcp50 [16410.587628] Key type .llcrypt unregistered [16410.595681] Key type ._llcrypt unregistered [16422.078040] Key type ._llcrypt registered [16422.079963] Key type .llcrypt registered [16423.510676] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 19:26:12 (1787354772) [16444.274809] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16444.296341] alg: No test for adler32 (adler32-zlib) [16445.742816] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [16446.129266] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [16447.927228] Key type lgssc registered [16449.692728] Lustre: Echo OBD driver; http://www.lustre.org/ [16546.865567] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16553.509566] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16580.840502] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16618.159405] Key type lgssc unregistered [16618.356943] LNet: 310690:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16618.364254] LNetError: 310690:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16618.376328] LNet: Removed LNI 192.168.202.39@tcp [16618.970914] Key type .llcrypt unregistered [16618.973951] Key type ._llcrypt unregistered [16631.127656] Key type ._llcrypt registered [16631.130383] Key type .llcrypt registered [16632.842492] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 19:29:41 (1787354981) [16635.897322] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16635.928401] alg: No test for adler32 (adler32-zlib) [16637.165763] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [16637.485218] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [16639.239624] Key type lgssc registered [16640.797301] Lustre: Echo OBD driver; http://www.lustre.org/ [16698.012879] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16704.178969] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16728.843876] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16730.818484] Lustre: Mounted lustre-client - version 2.17.57_44_g85e5bce [16804.310482] Lustre: Mounted fs15246-client - version 2.17.57_44_g85e5bce [16821.637038] Lustre: Unmounted fs15246-client [16849.682496] Lustre: Unmounted lustre-client [16878.751487] Key type lgssc unregistered [16878.975781] LNet: 315555:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16878.980935] LNetError: 315555:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16880.043819] LNet: Removed LNI 192.168.202.39@tcp [16881.055391] Key type .llcrypt unregistered [16881.059160] Key type ._llcrypt unregistered [16896.071501] Key type ._llcrypt registered [16896.079916] Key type .llcrypt registered [16898.321117] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 19:34:06 (1787355246) [16902.577228] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16902.628718] alg: No test for adler32 (adler32-zlib) [16904.219207] Lustre: Lustre: Build Version: 2.17.57_44_g85e5bce [16904.949352] LNet: Added LNI 192.168.202.39@tcp [8/256/0/180] [16906.896096] Key type lgssc registered [16908.842516] Lustre: Echo OBD driver; http://www.lustre.org/ [17069.612681] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [17075.613654] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [17105.114677] Lustre: DEBUG MARKER: oleg239-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [17214.219517] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16880 sec ========= 19:39:22 (1787355562) [17216.328748] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 19:39:24 (1787355564) === [17221.229416] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 19:39:29 (1787355569) === [17264.431207] Key type lgssc unregistered [17264.933494] LNet: 324831:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17264.942283] LNetError: 324831:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17264.965755] LNet: Removed LNI 192.168.202.39@tcp [17266.103921] Key type .llcrypt unregistered [17266.108990] Key type ._llcrypt unregistered