[ 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 464435718 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.002070] x2apic enabled [ 0.003004] Switched APIC routing to physical x2apic. [ 0.004013] kvm-guest: setup PV IPIs [ 0.006945] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007019] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008012] pid_max: default: 32768 minimum: 301 [ 0.009148] LSM: Security Framework initializing [ 0.010048] Yama: becoming mindful. [ 0.011038] SELinux: Initializing. [ 0.012068] *** VALIDATE selinux *** [ 0.020253] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024600] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025194] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026139] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027141] *** VALIDATE tmpfs *** [ 0.028000] *** VALIDATE proc *** [ 0.029108] *** VALIDATE cgroup *** [ 0.030010] *** VALIDATE cgroup2 *** [ 0.031268] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.033018] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.034007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.035046] Spectre V2 : User space: Vulnerable [ 0.036012] Speculative Store Bypass: Vulnerable [ 0.039120] debug: unmapping init [mem 0xffffffffa0a59000-0xffffffffa0a60fff] [ 0.042184] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043799] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044024] ... version: 2 [ 0.045021] ... bit width: 48 [ 0.046013] ... generic registers: 4 [ 0.047016] ... value mask: 0000ffffffffffff [ 0.048015] ... max period: 00007fffffffffff [ 0.049015] ... fixed-purpose events: 3 [ 0.050012] ... event mask: 000000070000000f [ 0.051356] rcu: Hierarchical SRCU implementation. [ 0.053440] smp: Bringing up secondary CPUs ... [ 0.054714] x86: Booting SMP configuration: [ 0.055040] .... node #0, CPUs: #1 #2 #3 [ 0.059133] smp: Brought up 1 node, 4 CPUs [ 0.061017] smpboot: Max logical packages: 1 [ 0.062015] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.184594] node 0 deferred pages initialised in 120ms [ 0.188007] devtmpfs: initialized [ 0.189261] x86/mm: Memory block size: 128MB [ 0.192404] gcov: version magic: 0x41383552 [ 0.193702] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.197101] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.201624] pinctrl core: initialized pinctrl subsystem [ 0.204200] [ 0.204720] ************************************************************* [ 0.207017] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.209010] ** ** [ 0.211014] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.213016] ** ** [ 0.216015] ** This means that this kernel is built to expose internal ** [ 0.219013] ** IOMMU data structures, which may compromise security on ** [ 0.221009] ** your system. ** [ 0.222011] ** ** [ 0.224015] ** If you see this message and you are not debugging the ** [ 0.226014] ** kernel, report this immediately to your vendor! ** [ 0.228011] ** ** [ 0.230015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.232011] ************************************************************* [ 0.234813] NET: Registered protocol family 16 [ 0.237378] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.240081] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.242068] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.246113] cpuidle: using governor menu [ 0.247789] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.251101] PCI: Using configuration type 1 for base access [ 0.253150] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.265065] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.266025] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.268032] cryptd: max_cpu_qlen set to 1000 [ 0.270089] ACPI: Added _OSI(Module Device) [ 0.271024] ACPI: Added _OSI(Processor Device) [ 0.272000] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.273020] ACPI: Added _OSI(Processor Aggregator Device) [ 0.278464] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.284131] ACPI: Interpreter enabled [ 0.285067] ACPI: PM: (supports S0 S3 S4 S5) [ 0.287013] ACPI: Using IOAPIC for interrupt routing [ 0.289148] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.293543] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.304715] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.307048] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.309024] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.313188] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.318524] acpiphp: Slot [2] registered [ 0.320134] acpiphp: Slot [5] registered [ 0.321119] acpiphp: Slot [6] registered [ 0.323134] acpiphp: Slot [3] registered [ 0.325100] acpiphp: Slot [4] registered [ 0.326082] acpiphp: Slot [7] registered [ 0.328127] acpiphp: Slot [8] registered [ 0.329161] acpiphp: Slot [9] registered [ 0.331105] acpiphp: Slot [10] registered [ 0.332071] acpiphp: Slot [11] registered [ 0.334107] acpiphp: Slot [12] registered [ 0.335095] acpiphp: Slot [13] registered [ 0.337133] acpiphp: Slot [14] registered [ 0.339122] acpiphp: Slot [15] registered [ 0.341079] acpiphp: Slot [16] registered [ 0.342114] acpiphp: Slot [17] registered [ 0.343068] acpiphp: Slot [18] registered [ 0.345112] acpiphp: Slot [19] registered [ 0.346000] acpiphp: Slot [20] registered [ 0.347147] acpiphp: Slot [21] registered [ 0.349108] acpiphp: Slot [22] registered [ 0.350081] acpiphp: Slot [23] registered [ 0.352099] acpiphp: Slot [24] registered [ 0.353064] acpiphp: Slot [25] registered [ 0.354067] acpiphp: Slot [26] registered [ 0.356130] acpiphp: Slot [27] registered [ 0.358081] acpiphp: Slot [28] registered [ 0.362169] acpiphp: Slot [29] registered [ 0.364092] acpiphp: Slot [30] registered [ 0.365098] acpiphp: Slot [31] registered [ 0.367099] PCI host bridge to bus 0000:00 [ 0.369024] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.371027] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.374026] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.376020] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.378026] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.381029] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.383212] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.386423] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.391597] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.401015] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.406525] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.409021] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.412087] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.415023] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.418599] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.422013] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.424049] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.429060] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.434019] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.447017] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.452845] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.460011] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.466016] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.475018] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.489912] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.499836] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.509017] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.517015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.533017] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.543000] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.546779] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.550807] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.553498] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.556317] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.563360] iommu: Default domain type: Passthrough [ 0.565515] SCSI subsystem initialized [ 0.567135] ACPI: bus type USB registered [ 0.568260] usbcore: registered new interface driver usbfs [ 0.570094] usbcore: registered new interface driver hub [ 0.574100] usbcore: registered new device driver usb [ 0.576202] pps_core: LinuxPPS API ver. 1 registered [ 0.578012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.582159] PTP clock support registered [ 0.584135] EDAC MC: Ver: 3.0.0 [ 0.586516] PCI: Using ACPI for IRQ routing [ 0.587486] NetLabel: Initializing [ 0.588000] NetLabel: domain hash size = 128 [ 0.591012] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.593115] NetLabel: unlabeled traffic allowed by default [ 0.596371] vgaarb: loaded [ 0.598355] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.600016] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.610000] clocksource: Switched to clocksource kvm-clock [ 0.723852] VFS: Disk quotas dquot_6.6.0 [ 0.726021] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.729414] *** VALIDATE ramfs *** [ 0.730618] *** VALIDATE hugetlbfs *** [ 0.732158] pnp: PnP ACPI init [ 0.735959] pnp: PnP ACPI: found 6 devices [ 0.751877] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.754640] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.757280] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.760822] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.763518] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.766382] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.769684] NET: Registered protocol family 2 [ 0.772328] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.777721] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.781572] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.786660] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.790590] TCP: Hash tables configured (established 65536 bind 65536) [ 0.793337] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.796341] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.798787] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.802665] NET: Registered protocol family 1 [ 0.805259] RPC: Registered named UNIX socket transport module. [ 0.806941] RPC: Registered udp transport module. [ 0.808377] RPC: Registered tcp transport module. [ 0.809644] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.811615] NET: Registered protocol family 44 [ 0.812995] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.814696] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.816322] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.818135] PCI: CLS 0 bytes, default 64 [ 0.819408] Unpacking initramfs... [ 2.320678] debug: unmapping init [mem 0xffff8d9ffcc64000-0xffff8d9ffffcffff] [ 2.325397] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.327515] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.330303] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.815605] Initialise system trusted keyrings [ 2.817779] Key type blacklist registered [ 2.819652] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.831567] zbud: loaded [ 2.834991] *** VALIDATE nfs *** [ 2.836434] *** VALIDATE nfs4 *** [ 2.838407] pstore: using deflate compression [ 2.842549] Platform Keyring initialized [ 2.946257] NET: Registered protocol family 38 [ 2.948067] Key type asymmetric registered [ 2.949765] Asymmetric key parser 'x509' registered [ 2.951811] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.955340] io scheduler mq-deadline registered [ 2.957158] io scheduler kyber registered [ 2.959126] io scheduler bfq registered [ 2.961332] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.964123] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.966642] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.969334] ACPI: Power Button [PWRF] [ 2.974394] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.982481] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.998640] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.028785] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.059750] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.065279] Non-volatile memory driver v1.3 [ 3.067288] Linux agpgart interface v0.103 [ 3.103113] virtio_blk virtio1: [vda] 149952 512-byte logical blocks (76.8 MB/73.2 MiB) [ 3.106476] vda: detected capacity change from 0 to 76775424 [ 3.125829] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.129265] vdb: detected capacity change from 0 to 1073741824 [ 3.136650] libphy: Fixed MDIO Bus: probed [ 3.150914] usbcore: registered new interface driver usbserial_generic [ 3.153282] usbserial: USB Serial support registered for generic [ 3.155171] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.158913] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.160404] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.162488] mousedev: PS/2 mouse device common for all mice [ 3.165603] rtc_cmos 00:05: RTC can wake from S4 [ 3.168379] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.168908] rtc_cmos 00:05: registered as rtc0 [ 3.173322] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.173937] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.176297] intel_pstate: CPU model not supported [ 3.184105] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.188638] hid: raw HID events driver (C) Jiri Kosina [ 3.191160] usbcore: registered new interface driver usbhid [ 3.193950] usbhid: USB HID core driver [ 3.195394] drop_monitor: Initializing network drop monitor service [ 3.197440] Initializing XFRM netlink socket [ 3.199772] NET: Registered protocol family 10 [ 3.202777] Segment Routing with IPv6 [ 3.205161] NET: Registered protocol family 17 [ 3.207651] mpls_gso: MPLS GSO support [ 3.213557] RAS: Correctable Errors collector initialized. [ 3.216090] AVX version of gcm_enc/dec engaged. [ 3.217966] AES CTR mode by8 optimization enabled [ 3.300821] sched_clock: Marking stable (3300742091, 0)->(4171716676, -870974585) [ 3.304328] registered taskstats version 1 [ 3.306423] Loading compiled-in X.509 certificates [ 3.308804] zswap: loaded using pool lzo/zbud [ 3.333888] Key type big_key registered [ 3.347343] Key type encrypted registered [ 3.348753] ima: No TPM chip found, activating TPM-bypass! [ 3.351045] ima: Allocated hash algorithm: sha1 [ 3.352364] ima: No architecture policies found [ 3.353839] evm: Initialising EVM extended attributes: [ 3.355387] evm: security.selinux [ 3.356482] evm: security.ima [ 3.357460] evm: security.capability [ 3.358700] evm: HMAC attrs: 0x1 [ 3.362649] rtc_cmos 00:05: setting system clock to 2026-09-07 15:52:49 UTC (1788796369) [ 3.372639] debug: unmapping init [mem 0xffffffffa1a03000-0xffffffffa1bfffff] [ 3.376241] debug: unmapping init [mem 0xffffffffa0782000-0xffffffffa0a58fff] [ 3.385400] Write protecting the kernel read-only data: 28672k [ 3.389465] debug: unmapping init [mem 0xffffffff9ee03000-0xffffffff9effffff] [ 3.392710] debug: unmapping init [mem 0xffffffff9f714000-0xffffffff9f7fffff] [ 3.431888] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.447392] systemd[1]: Detected virtualization kvm. [ 3.450028] systemd[1]: Detected architecture x86-64. [ 3.452623] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.476787] systemd[1]: No hostname configured. [ 3.478479] systemd[1]: Set hostname to . [ 3.480800] random: systemd: uninitialized urandom read (16 bytes read) [ 3.483941] systemd[1]: Initializing machine ID from random generator. [ 3.628639] random: systemd: uninitialized urandom read (16 bytes read) [ 3.632031] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.636264] random: systemd: uninitialized urandom read (16 bytes read) [ 3.641491] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 3.646120] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on udev Control Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on udev Kernel Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Paths. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Sockets. Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.331447] device-mapper: uevent: version 1.0.3 [ 4.333832] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon.[ 5.071478] random: fast init done [ 5.132707] virtio_net virtio0 ens2: renamed from eth0 [ 5.164134] scsi host0: ata_piix [ 5.169297] scsi host1: ata_piix [ 5.171360] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.175317] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.965436] dracut-initqueue[578]: RTNETLINK answers: File exists [ 9.865213] random: crng init done [ 9.866493] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.412485] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped Apply Kernel Variables. Stopping udev Kernel Device Manager... [ OK ] Stopped target Sockets. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.729515] printk: systemd: 25 output lines suppressed due to ratelimiting [ 12.060532] SELinux: Disabled at runtime. [ 12.120279] 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) [ 12.130075] systemd[1]: Detected virtualization kvm. [ 12.132325] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.679222] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.682762] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.687192] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.694813] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.700432] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.709160] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.716587] systemd[1]: Stopped target Switch Root. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on Process Core Dump Socket. [ OK ] Stopped target Initrd Root File System. Mounting POSIX Message Queue File System... Starting Create list of required st…ce nodes for the current kernel... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl s[ 12.793543] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS tatus proc-sys-fs-binfmt_misc.automount' for details. Mounting Kernel Debug File System... Starting Remount Root and Kernel File Systems... [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Control Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on initctl Compatibility Named Pipe. Starting Apply Kernel Variables... [ OK ] Created slice system-getty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... Mounting Huge Pages File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Huge Pages File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 13.348603] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.800662] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.817552] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 14.019739] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 14.070198] EDAC sbridge: Ver: 1.1.2 [ 15.533968] Key type dns_resolver registered [ 15.911697] NFS: Registering the id_resolver key type [ 15.914186] Key type id_resolver registered [ 15.915398] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started RPC Bind. [ OK ] Started Update UTMP about System Boot/Shutdown. [ 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 ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. [ OK ] Started irqbalance daemon. Starting Login Service... Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. Starting Network Manager... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ 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 GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started OpenSSH server daemon. [ 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 Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg604-client login: [ 50.675126] libcfs: loading out-of-tree module taints kernel. [ 50.751170] Key type ._llcrypt registered [ 50.752710] Key type .llcrypt registered [ 50.981390] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 50.990678] alg: No test for adler32 (adler32-zlib) [ 52.502815] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 53.484545] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 55.391209] Key type lgssc registered [ 57.098503] Lustre: Echo OBD driver; http://www.lustre.org/ [ 125.142273] hrtimer: interrupt took 4733853 ns [ 219.224891] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 223.363185] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 241.224985] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing check_logdir /tmp/testlogs/ [ 244.703487] Lustre: lustre-OST0000-osc-ffff8da045ff1000: disconnect after 23s idle [ 246.009824] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing yml_node [ 250.197384] Lustre: DEBUG MARKER: Client: 2.17.58.39 [ 252.287984] Lustre: DEBUG MARKER: MDS: 2.17.58.39 [ 254.271369] Lustre: DEBUG MARKER: OSS: 2.17.58.39 [ 256.115698] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon Sep 7 11:57:00 EDT 2026 [ 272.208849] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 273.350508] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 275.499729] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 285.867850] Lustre: Unmounted lustre-client [ 371.484259] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 375.987481] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 394.596316] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 434.249133] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 11:59:59 (1788796799) [ 436.231165] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 437.657801] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 12:00:02 (1788796802) [ 471.433468] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 476.953284] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 497.680137] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 498.292883] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 511.606335] Lustre: Unmounted lustre-client [ 538.386652] Key type lgssc unregistered [ 538.614142] LNet: 15066:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 538.620791] LNetError: 15066:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 538.637697] LNet: Removed LNI 192.168.206.4@tcp [ 539.301147] Key type .llcrypt unregistered [ 539.304602] Key type ._llcrypt unregistered [ 554.291338] Key type ._llcrypt registered [ 554.293730] Key type .llcrypt registered [ 555.450170] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 12:02:00 (1788796920) [ 556.866989] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 556.885214] alg: No test for adler32 (adler32-zlib) [ 557.946391] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 558.174387] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 559.863239] Key type lgssc registered [ 560.975799] Lustre: Echo OBD driver; http://www.lustre.org/ [ 643.354692] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 733.944160] Lustre: Unmounted lustre-client [ 761.692332] Key type lgssc unregistered [ 761.969036] LNet: 18847:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 761.983338] LNetError: 18847:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 762.001247] LNet: Removed LNI 192.168.206.4@tcp [ 762.636447] Key type .llcrypt unregistered [ 762.638129] Key type ._llcrypt unregistered [ 772.391933] Key type ._llcrypt registered [ 772.394717] Key type .llcrypt registered [ 773.588201] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 12:05:38 (1788797138) [ 775.442405] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 775.533858] alg: No test for adler32 (adler32-zlib) [ 776.518592] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 776.730959] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 778.375321] Key type lgssc registered [ 779.570545] Lustre: Echo OBD driver; http://www.lustre.org/ [ 824.581773] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 829.664868] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 848.340757] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 850.980036] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 860.538834] Lustre: Unmounted lustre-client [ 896.697887] Key type lgssc unregistered [ 896.950636] LNet: 22451:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 896.958050] LNetError: 22451:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 896.970506] LNet: Removed LNI 192.168.206.4@tcp [ 897.612611] Key type .llcrypt unregistered [ 897.615461] Key type ._llcrypt unregistered [ 906.651418] Key type ._llcrypt registered [ 906.655989] Key type .llcrypt registered [ 907.963477] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 12:07:52 (1788797272) [ 910.017593] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 910.041280] alg: No test for adler32 (adler32-zlib) [ 911.105693] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 911.366244] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 913.071251] Key type lgssc registered [ 914.337492] Lustre: Echo OBD driver; http://www.lustre.org/ [ 959.221962] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 964.438849] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 981.474961] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 983.904870] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 988.853611] Lustre: Unmounted lustre-client [ 1013.857774] Key type lgssc unregistered [ 1014.083732] LNet: 25643:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1014.090664] LNetError: 25643:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1014.116888] LNet: Removed LNI 192.168.206.4@tcp [ 1014.761897] Key type .llcrypt unregistered [ 1014.767356] Key type ._llcrypt unregistered [ 1027.920393] Key type ._llcrypt registered [ 1027.922527] Key type .llcrypt registered [ 1028.961310] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 12:09:53 (1788797393) [ 1030.756827] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1030.775868] alg: No test for adler32 (adler32-zlib) [ 1031.825638] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 1032.019142] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 1033.664469] Key type lgssc registered [ 1034.820630] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1076.855812] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1082.938236] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1103.401347] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1105.273073] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 1115.623633] Lustre: lustre-MDT0000-mdc-ffff8da0502d1000: Connection to lustre-MDT0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1125.866285] Lustre: lustre-MDT0001-mdc-ffff8da0502d1000: Connection to lustre-MDT0001 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1129.988941] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1136.095646] Lustre: 26597:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788797486/real 1788797486] req@000000001f244050 x1875690020411392/t0(0) o400->MGC192.168.206.104@tcp@192.168.206.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1788797502 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1136.128751] LustreError: MGC192.168.206.104@tcp: Connection to MGS (at 192.168.206.104@tcp) was lost; in progress operations using this service will fail [ 1140.316808] Lustre: Unmounted lustre-client [ 1157.264426] Key type lgssc unregistered [ 1157.514453] LNet: 29296:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1157.524889] LNetError: 29296:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1157.552279] LNet: Removed LNI 192.168.206.4@tcp [ 1158.212831] Key type .llcrypt unregistered [ 1158.216515] Key type ._llcrypt unregistered [ 1169.966894] Key type ._llcrypt registered [ 1169.970952] Key type .llcrypt registered [ 1171.191723] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 12:12:15 (1788797535) [ 1173.215166] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1173.235043] alg: No test for adler32 (adler32-zlib) [ 1174.215631] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 1174.439736] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 1176.128385] Key type lgssc registered [ 1177.029979] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1216.793560] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1222.056751] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1241.576639] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1247.303081] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 1252.339571] Lustre: lustre-OST0000-osc-ffff8da0502d3800: Connection to lustre-OST0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1259.188824] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1269.545596] Lustre: Unmounted lustre-client [ 1293.453840] Key type lgssc unregistered [ 1293.693686] LNet: 32903:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1293.702298] LNetError: 32903:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1294.760524] LNet: Removed LNI 192.168.206.4@tcp [ 1295.298189] Key type .llcrypt unregistered [ 1295.300515] Key type ._llcrypt unregistered [ 1308.274889] Key type ._llcrypt registered [ 1308.277368] Key type .llcrypt registered [ 1309.128164] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 12:14:34 (1788797674) [ 1311.031895] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1311.048623] alg: No test for adler32 (adler32-zlib) [ 1312.178973] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 1312.488288] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 1314.191554] Key type lgssc registered [ 1315.208538] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1353.390083] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1358.238447] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1375.027922] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1381.932507] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 1385.056953] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1387.898297] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1399.327832] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-0712h16m04s [ 1401.405167] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1407.469055] Lustre: lustre-MDT0000-mdc-ffff8da05856a800: Connection to lustre-MDT0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1411.549865] LustreError: 36684:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8da05856a800: can't stat MDS #0: rc = -19 [ 1413.061571] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1419.749154] LustreError: MGC192.168.206.104@tcp: Connection to MGS (at 192.168.206.104@tcp) was lost; in progress operations using this service will fail [ 1419.776530] Lustre: Evicted from MGS (at 192.168.206.104@tcp) after server handle changed from 0xc390d6bc7bd3aa9c to 0xc390d6bc7bd3ae2a [ 1419.798402] LustreError: lustre-MDT0000-mdc-ffff8da05856a800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1419.800354] Lustre: MGC192.168.206.104@tcp: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 1425.785181] Lustre: DEBUG MARKER: Wait for df (36684) ... [ 1426.947574] Lustre: DEBUG MARKER: done [ 1428.902192] Lustre: Unmounted lustre-client [ 1453.603121] Key type lgssc unregistered [ 1453.812580] LNet: 37695:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1453.820604] LNetError: 37695:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1453.839101] LNet: Removed LNI 192.168.206.4@tcp [ 1454.382851] Key type .llcrypt unregistered [ 1454.385989] Key type ._llcrypt unregistered [ 1479.917606] Key type ._llcrypt registered [ 1479.919278] Key type .llcrypt registered [ 1481.029595] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 12:17:25 (1788797845) [ 1483.470188] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1483.495186] alg: No test for adler32 (adler32-zlib) [ 1484.502837] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 1484.690661] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 1486.335467] Key type lgssc registered [ 1487.294687] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1530.166925] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1534.819568] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1551.419928] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1553.868503] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 1557.659361] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-0712h18m42s [ 1559.018635] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1565.670846] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1567.991817] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1588.192085] Lustre: 41829:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788797934/real 1788797934] req@0000000074dd5a96 x1875690494368000/t0(0) o101->lustre-MDT0000-mdc-ffff8da050243000@192.168.206.104@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788797954 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1588.230718] Lustre: lustre-MDT0000-mdc-ffff8da050243000: Connection to lustre-MDT0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1588.278916] Lustre: lustre-MDT0000-mdc-ffff8da050243000: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 1609.362353] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1612.164354] Lustre: DEBUG MARKER: done [ 1616.306067] Lustre: Unmounted lustre-client [ 1645.562989] Key type lgssc unregistered [ 1645.819843] LNet: 42715:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1645.829239] LNetError: 42715:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1645.849621] LNet: Removed LNI 192.168.206.4@tcp [ 1646.445678] Key type .llcrypt unregistered [ 1646.448451] Key type ._llcrypt unregistered [ 1670.877556] Key type ._llcrypt registered [ 1670.882523] Key type .llcrypt registered [ 1672.157411] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 12:20:36 (1788798036) [ 1673.635506] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1675.303101] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 12:20:40 (1788798040) [ 1680.093783] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1680.111673] alg: No test for adler32 (adler32-zlib) [ 1681.081215] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 1681.267714] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 1682.959241] Key type lgssc registered [ 1683.986492] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1714.791229] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 12:21:19 (1788798079) [ 1749.429539] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1754.850983] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1775.988384] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1778.684257] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 1781.951866] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1785.369645] Lustre: Unmounted lustre-client [ 1801.649967] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1848.450972] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1853.473576] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1854.118726] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 1858.372359] Lustre: Unmounted lustre-client [ 1922.127659] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1927.651270] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1928.424781] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 1933.101551] Lustre: Unmounted lustre-client [ 1954.879955] Lustre: DEBUG MARKER: files compared the same [ 1977.704933] Key type lgssc unregistered [ 1978.040089] LNet: 50335:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1978.050473] LNetError: 50335:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1978.075402] LNet: Removed LNI 192.168.206.4@tcp [ 1978.719867] Key type .llcrypt unregistered [ 1978.722559] Key type ._llcrypt unregistered [ 1994.752594] Key type ._llcrypt registered [ 1994.754875] Key type .llcrypt registered [ 1996.025563] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 12:26:00 (1788798360) [ 1998.275574] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1998.364567] alg: No test for adler32 (adler32-zlib) [ 1999.518954] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 1999.788342] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 2001.447197] Key type lgssc registered [ 2002.585782] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2056.575519] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2061.709308] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2081.545397] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2084.180584] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 2087.828396] Lustre: Unmounted lustre-client [ 2122.152161] Key type lgssc unregistered [ 2122.397814] LNet: 53915:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2122.405304] LNetError: 53915:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2122.434425] LNet: Removed LNI 192.168.206.4@tcp [ 2122.988869] Key type .llcrypt unregistered [ 2122.991974] Key type ._llcrypt unregistered [ 2135.513299] Key type ._llcrypt registered [ 2135.517842] Key type .llcrypt registered [ 2136.850798] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 12:28:21 (1788798501) [ 2138.669678] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2138.701996] alg: No test for adler32 (adler32-zlib) [ 2139.713477] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 2139.921234] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 2141.575314] Key type lgssc registered [ 2142.608645] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2221.551547] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2248.951603] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2253.417901] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2278.140878] Key type lgssc unregistered [ 2278.428374] LNet: 57392:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2278.441557] LNetError: 57392:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2278.478156] LNet: Removed LNI 192.168.206.4@tcp [ 2279.299367] Key type .llcrypt unregistered [ 2279.303148] Key type ._llcrypt unregistered [ 2293.816205] Key type ._llcrypt registered [ 2293.817984] Key type .llcrypt registered [ 2295.133268] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 12:30:59 (1788798659) [ 2298.114249] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2298.149879] alg: No test for adler32 (adler32-zlib) [ 2299.184226] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 2299.383980] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 2301.031229] Key type lgssc registered [ 2302.312579] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2372.601911] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 2380.206092] Lustre: Unmounted lustre-client [ 2417.470712] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 12:33:02 (1788798782) [ 2533.661683] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2547.961513] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 2554.508910] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2554.515570] LustreError: 63850:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8da0502d4000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2554.538439] Lustre: 58371:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.104@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2564.917779] Lustre: Unmounted lustre-client [ 2608.409685] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 12:36:13 (1788798973) [ 2618.790951] Key type lgssc unregistered [ 2619.080712] LNet: 65061:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2619.088194] LNetError: 65061:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2619.101486] LNet: Removed LNI 192.168.206.4@tcp [ 2619.713895] Key type .llcrypt unregistered [ 2619.719759] Key type ._llcrypt unregistered [ 2630.546638] Key type ._llcrypt registered [ 2630.561950] Key type .llcrypt registered [ 2630.971513] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2630.982075] alg: No test for adler32 (adler32-zlib) [ 2632.075874] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 2632.348455] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 2634.087443] Key type lgssc registered [ 2635.510376] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2687.581780] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2694.310463] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2714.641215] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2716.578658] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 2724.968519] Lustre: Unmounted lustre-client [ 2754.092270] Key type lgssc unregistered [ 2754.440525] LNet: 68068:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2754.448601] LNetError: 68068:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2754.474267] LNet: Removed LNI 192.168.206.4@tcp [ 2755.375510] Key type .llcrypt unregistered [ 2755.391305] Key type ._llcrypt unregistered [ 2768.138183] Key type ._llcrypt registered [ 2768.142551] Key type .llcrypt registered [ 2768.712983] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2768.729098] alg: No test for adler32 (adler32-zlib) [ 2769.849223] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 2770.143914] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 2771.776495] Key type lgssc registered [ 2772.937458] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2886.838829] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2893.500873] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2915.776747] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2917.561332] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 2925.629294] Lustre: Unmounted lustre-client [ 2954.829674] Key type lgssc unregistered [ 2955.061216] LNet: 71494:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2955.078144] LNetError: 71494:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2955.095801] LNet: Removed LNI 192.168.206.4@tcp [ 2955.941961] Key type .llcrypt unregistered [ 2955.945063] Key type ._llcrypt unregistered [ 2970.648079] Key type ._llcrypt registered [ 2970.649350] Key type .llcrypt registered [ 2971.834976] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 12:42:16 (1788799336) [ 2974.267338] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2974.285946] alg: No test for adler32 (adler32-zlib) [ 2975.509853] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 2975.850709] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 2977.511347] Key type lgssc registered [ 2979.233796] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3031.934530] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3037.322200] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3060.736453] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3063.674195] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 3072.792757] Lustre: Unmounted lustre-client [ 3073.366068] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 3076.432353] Lustre: Unmounted lustre-client [ 3104.377552] Key type lgssc unregistered [ 3104.774944] LNet: 75178:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3104.784778] LNetError: 75178:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3104.822438] LNet: Removed LNI 192.168.206.4@tcp [ 3105.826339] Key type .llcrypt unregistered [ 3105.833128] Key type ._llcrypt unregistered [ 3119.025759] Key type ._llcrypt registered [ 3119.038901] Key type .llcrypt registered [ 3119.837633] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3119.887244] alg: No test for adler32 (adler32-zlib) [ 3121.324826] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 3121.809394] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 3123.592363] Key type lgssc registered [ 3125.512632] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3178.332995] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3184.361241] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3205.451106] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3207.325618] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 3215.295346] Lustre: Unmounted lustre-client [ 3244.529255] Key type lgssc unregistered [ 3244.814898] LNet: 78215:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3244.827386] LNetError: 78215:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3244.856473] LNet: Removed LNI 192.168.206.4@tcp [ 3245.838186] Key type .llcrypt unregistered [ 3245.847485] Key type ._llcrypt unregistered [ 3260.369304] Key type ._llcrypt registered [ 3260.371360] Key type .llcrypt registered [ 3261.516846] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 12:47:06 (1788799626) [ 3264.174445] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3264.217909] alg: No test for adler32 (adler32-zlib) [ 3265.319317] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 3265.583758] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 3267.288759] Key type lgssc registered [ 3268.395092] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3317.833774] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3324.217833] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3348.558233] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3351.331840] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 3365.492414] Lustre: lustre: root_squash is set to 0:0 [ 3365.521960] Lustre: lustre: nosquash_nids is cleared [ 3370.665466] Lustre: lustre: root_squash is set to 500:500 [ 3380.219066] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.4@tcp 192.168.0.[2,10]@tcp [ 3389.792743] Lustre: lustre: nosquash_nids set to 192.168.206.4/24@tcp [ 3393.033749] Lustre: Unmounted lustre-client [ 3425.617341] Key type lgssc unregistered [ 3425.905075] LNet: 82154:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3425.922828] LNetError: 82154:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3425.940587] LNet: Removed LNI 192.168.206.4@tcp [ 3426.631122] Key type .llcrypt unregistered [ 3426.635457] Key type ._llcrypt unregistered [ 3441.595363] Key type ._llcrypt registered [ 3441.597780] Key type .llcrypt registered [ 3442.786481] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 12:50:07 (1788799807) [ 3445.107603] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3447.617802] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 12:50:12 (1788799812) [ 3449.748874] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3449.786965] alg: No test for adler32 (adler32-zlib) [ 3450.900916] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 3451.145763] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 3452.831367] Key type lgssc registered [ 3454.113771] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3503.548110] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3508.458940] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3527.050799] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3527.554271] Lustre: lustre: root_squash is set to 500:500 [ 3527.582779] Lustre: lustre: nosquash_nids set to 192.168.206.4/24@tcp [ 3528.689469] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 3534.344605] Lustre: Unmounted lustre-client [ 3561.061808] Key type lgssc unregistered [ 3561.420937] LNet: 86106:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3561.444255] LNetError: 86106:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3561.472609] LNet: Removed LNI 192.168.206.4@tcp [ 3562.501595] Key type .llcrypt unregistered [ 3562.503547] Key type ._llcrypt unregistered [ 3576.689120] Key type ._llcrypt registered [ 3576.691497] Key type .llcrypt registered [ 3577.922452] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3579.281266] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 12:52:24 (1788799944) [ 3595.030395] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3595.050789] alg: No test for adler32 (adler32-zlib) [ 3596.065545] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 3596.376237] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 3598.055582] Key type lgssc registered [ 3599.201697] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3687.096853] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3694.366222] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3718.899732] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3789.043769] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3795.146909] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3816.566415] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3828.081705] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 3858.521294] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8da044784800.ost_server_uuid 50 [ 3859.998515] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8da044784800.ost_server_uuid in FULL state after 0 sec [ 3860.464345] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 3864.266281] Lustre: Unmounted lustre-client [ 3866.168885] Lustre: Unmounted lustre-client [ 3916.602545] Key type lgssc unregistered [ 3916.843219] LNet: 93770:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3916.850731] LNetError: 93770:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3916.864390] LNet: Removed LNI 192.168.206.4@tcp [ 3917.451080] Key type .llcrypt unregistered [ 3917.453618] Key type ._llcrypt unregistered [ 3943.963348] Key type ._llcrypt registered [ 3943.973260] Key type .llcrypt registered [ 3945.359449] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 12:58:29 (1788800309) [ 3959.735595] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3959.779174] alg: No test for adler32 (adler32-zlib) [ 3960.841465] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 3961.127650] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 3962.879397] Key type lgssc registered [ 3963.912306] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4032.460210] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4038.897675] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4059.339457] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4062.173588] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 4083.664153] Lustre: 95129:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788800433/real 1788800433] req@0000000024551d78 x1875693091689856/t0(0) o400->lustre-OST0000-osc-ffff8da058671000@192.168.206.104@tcp:28/4 lens 224/224 e 0 to 1 dl 1788800449 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4083.704882] Lustre: lustre-OST0000-osc-ffff8da058671000: Connection to lustre-OST0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4088.671153] Lustre: 95130:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788800438/real 1788800438] req@0000000046877857 x1875693091690368/t0(0) o400->lustre-OST0000-osc-ffff8da058671000@192.168.206.104@tcp:28/4 lens 224/224 e 0 to 1 dl 1788800454 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4092.896911] Lustre: 95130:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788800443/real 1788800443] req@00000000d7dcef1d x1875693091690880/t0(0) o400->lustre-OST0000-osc-ffff8da058671000@192.168.206.104@tcp:28/4 lens 224/224 e 0 to 1 dl 1788800459 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4093.934442] Lustre: lustre-MDT0000-mdc-ffff8da058671000: Connection to lustre-MDT0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4098.015348] Lustre: 95129:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788800448/real 1788800448] req@00000000aa812564 x1875693091691392/t0(0) o400->lustre-OST0000-osc-ffff8da058671000@192.168.206.104@tcp:28/4 lens 224/224 e 0 to 1 dl 1788800464 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4110.303420] Lustre: 95128:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788800460/real 1788800460] req@000000000ee50a70 x1875693091692800/t0(0) o400->MGC192.168.206.104@tcp@192.168.206.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1788800476 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4110.335513] LustreError: MGC192.168.206.104@tcp: Connection to MGS (at 192.168.206.104@tcp) was lost; in progress operations using this service will fail [ 4120.567189] Lustre: Evicted from MGS (at 192.168.206.104@tcp) after server handle changed from 0xe4e9d6aa9f05c5ed to 0xe4e9d6aa9f05c8b0 [ 4120.588404] Lustre: MGC192.168.206.104@tcp: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 4124.130513] Lustre: lustre-MDT0000-mdc-ffff8da058671000: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 4127.883757] Lustre: Unmounted lustre-client [ 4143.211132] Key type lgssc unregistered [ 4143.567726] LNet: 99435:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4143.573662] LNetError: 99435:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4143.596827] LNet: Removed LNI 192.168.206.4@tcp [ 4144.548626] Key type .llcrypt unregistered [ 4144.552071] Key type ._llcrypt unregistered [ 4161.535531] Key type ._llcrypt registered [ 4161.540350] Key type .llcrypt registered [ 4162.876685] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 13:02:07 (1788800527) [ 4177.499449] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4177.685355] alg: No test for adler32 (adler32-zlib) [ 4178.753267] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 4178.950642] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 4180.599229] Key type lgssc registered [ 4181.562497] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4218.847806] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4315.715470] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4320.641231] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4345.765312] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4347.443503] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 4349.205717] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4351.106478] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 13:05:15 (1788800715) [ 4562.273972] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4572.656486] Lustre: Unmounted lustre-client [ 4693.279584] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4699.513848] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4721.772415] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4768.980768] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 13:12:13 (1788801133) [ 4855.886138] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4860.451719] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4881.082472] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4881.479346] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 4884.879165] Lustre: Unmounted lustre-client [ 4917.048739] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 13:14:41 (1788801281) [ 4999.306854] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5004.057190] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5025.265181] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5025.991176] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 5029.815282] Lustre: Unmounted lustre-client [ 5063.271831] Key type lgssc unregistered [ 5063.496556] LNet: 122446:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5063.513229] LNetError: 122446:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5063.543884] LNet: Removed LNI 192.168.206.4@tcp [ 5064.142278] Key type .llcrypt unregistered [ 5064.144642] Key type ._llcrypt unregistered [ 5077.541565] Key type ._llcrypt registered [ 5077.543798] Key type .llcrypt registered [ 5078.565143] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 13:17:23 (1788801443) [ 5080.504919] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5080.520505] alg: No test for adler32 (adler32-zlib) [ 5081.515877] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 5081.695116] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 5083.336254] Key type lgssc registered [ 5084.240047] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5130.506982] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5135.092598] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5153.583251] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5156.261302] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 5169.729076] Lustre: Unmounted lustre-client [ 5196.118944] Key type lgssc unregistered [ 5196.419060] LNet: 126036:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5196.434526] LNetError: 126036:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5196.472883] LNet: Removed LNI 192.168.206.4@tcp [ 5197.283554] Key type .llcrypt unregistered [ 5197.285663] Key type ._llcrypt unregistered [ 5212.964706] Key type ._llcrypt registered [ 5212.970471] Key type .llcrypt registered [ 5214.324931] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 13:19:38 (1788801578) [ 5217.262888] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5217.399715] alg: No test for adler32 (adler32-zlib) [ 5218.363508] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 5218.514749] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 5220.191238] Key type lgssc registered [ 5221.545174] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5267.342221] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5272.408445] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5298.636444] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5300.357840] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 5310.966852] Lustre: lustre-OST0000-osc-ffff8da0580ea800: Connection to lustre-OST0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5321.230802] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8da0580ea800.ost_server_uuid 50 [ 5322.859349] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5334.667490] Lustre: Unmounted lustre-client [ 5354.485833] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 13:21:59 (1788801719) [ 5384.505956] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5390.393990] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5412.569655] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5436.552584] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5437.024157] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 5442.035795] Lustre: lustre-OST0000-osc-ffff8da058677000: Connection to lustre-OST0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5469.148195] Lustre: Unmounted lustre-client [ 5525.904510] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 13:24:50 (1788801890) [ 5555.580365] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5560.588783] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5578.102557] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5595.116623] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5595.549526] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 5600.745470] Lustre: lustre-OST0000-osc-ffff8da058672000: Connection to lustre-OST0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5616.391070] Lustre: Unmounted lustre-client [ 5658.009722] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 13:27:02 (1788802022) [ 5741.194547] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5746.082840] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5764.990971] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5828.821708] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5833.129135] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5850.056043] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5884.073450] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 5922.093785] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5930.896410] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 7 sec [ 5932.447786] Lustre: Unmounted lustre-client [ 5965.179766] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 13:32:10 (1788802330) [ 5994.659262] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6000.369609] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6023.465938] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6050.819731] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6081.256199] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 6122.935583] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6124.316560] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6127.589983] Lustre: lustre-OST0001-osc-ffff8da045096800: Connection to lustre-OST0001 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6135.718708] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6146.110492] Lustre: Unmounted lustre-client [ 6200.047601] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 13:36:04 (1788802564) [ 6230.605381] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6235.620742] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6253.457882] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6253.921149] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 6276.289928] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6278.032934] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6294.225513] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8da04424d000.ost_server_uuid 50 [ 6295.795260] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8da04424d000.ost_server_uuid in IDLE state after 0 sec [ 6299.308463] Lustre: Unmounted lustre-client [ 6299.766021] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6299.778548] Lustre: Skipped 3 previous similar messages [ 6299.915882] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 6301.158315] LustreError: 149502:0:(sec.c:409:import_sec_validate_get()) import 0000000032cc9b76 (NEW) with no sec [ 6369.252710] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 13:38:54 (1788802734) [ 6401.041592] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6406.403525] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6426.256238] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6445.583325] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6445.991072] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6446.122550] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 6457.264982] Lustre: Unmounted lustre-client [ 6457.269629] Lustre: Skipped 1 previous similar message [ 6492.349431] Key type lgssc unregistered [ 6492.672838] LNet: 152906:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6492.688571] LNetError: 152906:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6492.713592] LNet: Removed LNI 192.168.206.4@tcp [ 6493.360239] Key type .llcrypt unregistered [ 6493.361931] Key type ._llcrypt unregistered [ 6510.776688] Key type ._llcrypt registered [ 6510.780177] Key type .llcrypt registered [ 6512.022562] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 13:41:16 (1788802876) [ 6512.803308] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6512.816204] alg: No test for adler32 (adler32-zlib) [ 6513.830232] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 6514.078462] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 6515.847253] Key type lgssc registered [ 6516.897590] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6562.254778] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6567.237796] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6587.486280] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6605.022574] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6605.458754] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6606.606356] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 6612.533253] LustreError: lustre-MDT0001-mdc-ffff8da05369b000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6612.580431] Lustre: lustre-MDT0001-mdc-ffff8da05369b000: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 6618.591502] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6619.990116] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6639.103139] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6642.094594] Lustre: Unmounted lustre-client [ 6673.853568] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 13:43:58 (1788803038) [ 6760.816924] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6767.541900] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6788.994757] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6789.545102] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 6812.786616] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6814.209353] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6816.259085] Lustre: lustre-OST0001-osc-ffff8da050252800: Connection to lustre-OST0001 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6825.579559] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6835.932779] Lustre: Unmounted lustre-client [ 6867.919420] Key type lgssc unregistered [ 6868.208292] LNet: 162495:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6868.217095] LNetError: 162495:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6868.236077] LNet: Removed LNI 192.168.206.4@tcp [ 6868.865808] Key type .llcrypt unregistered [ 6868.867939] Key type ._llcrypt unregistered [ 6895.796439] Key type ._llcrypt registered [ 6895.798126] Key type .llcrypt registered [ 6896.995698] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 13:47:41 (1788803261) [ 6898.839174] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6898.894409] alg: No test for adler32 (adler32-zlib) [ 6899.988179] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 6900.205254] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 6901.863887] Key type lgssc registered [ 6903.180371] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6952.428412] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6959.942791] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6982.492543] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6984.343362] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 7032.048314] Lustre: Unmounted lustre-client [ 7071.771423] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7072.363468] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 7107.330085] Lustre: Unmounted lustre-client [ 7132.213331] Key type lgssc unregistered [ 7132.413796] LNet: 166937:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7132.426503] LNetError: 166937:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7132.443553] LNet: Removed LNI 192.168.206.4@tcp [ 7132.989826] Key type .llcrypt unregistered [ 7132.994950] Key type ._llcrypt unregistered [ 7145.222274] Key type ._llcrypt registered [ 7145.225143] Key type .llcrypt registered [ 7146.346561] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 13:51:51 (1788803511) [ 7148.566836] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7148.599976] alg: No test for adler32 (adler32-zlib) [ 7149.720885] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 7149.935357] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 7151.591291] Key type lgssc registered [ 7152.547717] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7203.914534] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7209.361620] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7229.740763] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7231.716718] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 7251.478458] Lustre: Unmounted lustre-client [ 7276.499288] Key type lgssc unregistered [ 7276.755710] LNet: 170688:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7276.769190] LNetError: 170688:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7276.790882] LNet: Removed LNI 192.168.206.4@tcp [ 7277.284726] Key type .llcrypt unregistered [ 7277.287181] Key type ._llcrypt unregistered [ 7287.118897] Key type ._llcrypt registered [ 7287.125925] Key type .llcrypt registered [ 7287.467117] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7287.476476] alg: No test for adler32 (adler32-zlib) [ 7288.557921] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 7288.800540] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 7290.496124] Key type lgssc registered [ 7291.651652] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7337.912323] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7343.443110] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7364.511970] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7366.199167] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 7374.275624] Lustre: Unmounted lustre-client [ 7403.056075] Key type lgssc unregistered [ 7403.342264] LNet: 173748:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7403.351059] LNetError: 173748:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7403.366412] LNet: Removed LNI 192.168.206.4@tcp [ 7404.003736] Key type .llcrypt unregistered [ 7404.005429] Key type ._llcrypt unregistered [ 7418.833074] Key type ._llcrypt registered [ 7418.835344] Key type .llcrypt registered [ 7420.535441] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 13:56:24 (1788803784) [ 7422.313868] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7422.450900] alg: No test for adler32 (adler32-zlib) [ 7423.632624] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 7423.992995] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 7425.671352] Key type lgssc registered [ 7426.766583] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7474.462930] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7479.663250] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7497.855430] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7499.428791] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 7515.960529] Lustre: Unmounted lustre-client [ 7552.808477] Key type lgssc unregistered [ 7553.064064] LNet: 177500:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7553.075822] LNetError: 177500:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7553.095497] LNet: Removed LNI 192.168.206.4@tcp [ 7553.932662] Key type .llcrypt unregistered [ 7553.935737] Key type ._llcrypt unregistered [ 7565.340278] Key type ._llcrypt registered [ 7565.343883] Key type .llcrypt registered [ 7565.850937] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7565.864959] alg: No test for adler32 (adler32-zlib) [ 7567.008947] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 7567.223673] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 7568.912429] Key type lgssc registered [ 7570.526629] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7616.596665] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7621.982314] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7643.415845] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7645.086549] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 7654.005738] Lustre: Unmounted lustre-client [ 7692.924346] Key type lgssc unregistered [ 7693.267465] LNet: 180564:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7693.287381] LNetError: 180564:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7693.305223] LNet: Removed LNI 192.168.206.4@tcp [ 7694.429764] Key type .llcrypt unregistered [ 7694.435825] Key type ._llcrypt unregistered [ 7710.266976] Key type ._llcrypt registered [ 7710.268896] Key type .llcrypt registered [ 7711.992188] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 14:01:16 (1788804076) [ 7732.658608] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7732.776526] alg: No test for adler32 (adler32-zlib) [ 7733.792490] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 7733.968355] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 7735.615229] Key type lgssc registered [ 7737.004781] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7827.716244] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7833.448247] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7856.920766] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7905.779137] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 14:04:30 (1788804270) [ 7940.234189] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7946.470591] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7968.581581] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7971.501703] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 7980.711825] Lustre: Unmounted lustre-client [ 8010.114671] Key type lgssc unregistered [ 8010.441868] LNet: 187675:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8010.452413] LNetError: 187675:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8010.485353] LNet: Removed LNI 192.168.206.4@tcp [ 8011.292110] Key type .llcrypt unregistered [ 8011.294775] Key type ._llcrypt unregistered [ 8026.616655] Key type ._llcrypt registered [ 8026.622364] Key type .llcrypt registered [ 8027.831818] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8029.374894] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 14:06:34 (1788804394) [ 8047.524865] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8047.537264] alg: No test for adler32 (adler32-zlib) [ 8048.653551] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 8048.874861] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 8050.551258] Key type lgssc registered [ 8051.967805] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8140.549272] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8146.216989] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8169.978745] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8190.049125] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8191.793703] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 8215.379704] Lustre: Unmounted lustre-client [ 8339.332784] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8344.713552] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8365.043126] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8412.552413] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 14:12:57 (1788804777) [ 8413.873714] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8416.020382] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 14:13:00 (1788804780) [ 8507.821672] Key type lgssc unregistered [ 8508.072281] LNet: 199116:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8508.085351] LNetError: 199116:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8508.099809] LNet: Removed LNI 192.168.206.4@tcp [ 8508.821499] Key type .llcrypt unregistered [ 8508.823427] Key type ._llcrypt unregistered [ 8523.476280] Key type ._llcrypt registered [ 8523.480940] Key type .llcrypt registered [ 8525.085454] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 14:14:49 (1788804889) [ 8564.549988] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8564.573866] alg: No test for adler32 (adler32-zlib) [ 8565.555417] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 8565.830566] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 8567.519418] Key type lgssc registered [ 8568.724612] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8604.669365] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8608.908048] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8639.340528] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8663.938359] Key type lgssc unregistered [ 8664.152662] LNet: 202842:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8664.161601] LNetError: 202842:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8664.177610] LNet: Removed LNI 192.168.206.4@tcp [ 8664.648544] Key type .llcrypt unregistered [ 8664.653918] Key type ._llcrypt unregistered [ 8676.484191] Key type ._llcrypt registered [ 8676.488536] Key type .llcrypt registered [ 8677.737542] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 14:17:22 (1788805042) [ 8679.960158] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8679.972246] alg: No test for adler32 (adler32-zlib) [ 8681.063276] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 8681.328312] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 8682.999349] Key type lgssc registered [ 8684.027521] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8722.244551] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8726.592471] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8745.554627] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8748.144141] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 8753.133586] Lustre: lustre-MDT0000-mdc-ffff8da0550f4800: Connection to lustre-MDT0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8758.255544] Lustre: lustre-MDT0001-mdc-ffff8da0550f4800: Connection to lustre-MDT0001 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8769.506389] Lustre: 203827:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788805119/real 1788805119] req@00000000ab917ff9 x1875698041043968/t0(0) o400->MGC192.168.206.104@tcp@192.168.206.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1788805135 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 8769.543265] LustreError: MGC192.168.206.104@tcp: Connection to MGS (at 192.168.206.104@tcp) was lost; in progress operations using this service will fail [ 8779.818918] Lustre: Evicted from MGS (at 192.168.206.104@tcp) after server handle changed from 0x33e0768186718fe1 to 0x33e076818671a91e [ 8779.827965] Lustre: MGC192.168.206.104@tcp: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 8798.187424] LustreError: lustre-MDT0000-mdc-ffff8da0550f4800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 8798.236906] Lustre: lustre-MDT0000-mdc-ffff8da0550f4800: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 8802.456930] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8803.620677] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8808.273099] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8809.483914] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8811.566049] Lustre: Unmounted lustre-client [ 8835.576585] Key type lgssc unregistered [ 8835.793900] LNet: 207780:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8835.802025] LNetError: 207780:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8835.821268] LNet: Removed LNI 192.168.206.4@tcp [ 8836.297417] Key type .llcrypt unregistered [ 8836.299037] Key type ._llcrypt unregistered [ 8848.052445] Key type ._llcrypt registered [ 8848.057249] Key type .llcrypt registered [ 8849.054520] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 14:20:14 (1788805214) [ 8850.769461] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8850.841096] alg: No test for adler32 (adler32-zlib) [ 8851.848562] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 8852.021578] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 8853.656253] Key type lgssc registered [ 8854.484958] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8893.047465] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8897.763947] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8940.340599] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8945.238511] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8971.886533] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8986.689126] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9015.305024] Key type lgssc unregistered [ 9015.487665] LNet: 213058:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9015.494081] LNetError: 213058:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9015.504155] LNet: Removed LNI 192.168.206.4@tcp [ 9015.952866] Key type .llcrypt unregistered [ 9015.954705] Key type ._llcrypt unregistered [ 9047.896871] Key type ._llcrypt registered [ 9047.899153] Key type .llcrypt registered [ 9048.791052] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 14:23:33 (1788805413) [ 9071.423471] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9071.476267] alg: No test for adler32 (adler32-zlib) [ 9072.453933] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 9072.657755] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 9074.320692] Key type lgssc registered [ 9075.127073] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9130.880114] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9134.552356] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9150.370492] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9190.280471] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 14:25:55 (1788805555) [ 9195.374193] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 14:26:00 (1788805560) [ 9217.021902] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9220.538801] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9234.341504] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9235.798092] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 9240.099182] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9241.167622] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9242.229164] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9243.326857] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9246.180624] Lustre: lustre-MDT0000-mdc-ffff8da0441f3800: Connection to lustre-MDT0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9261.547331] LustreError: MGC192.168.206.104@tcp: Connection to MGS (at 192.168.206.104@tcp) was lost; in progress operations using this service will fail [ 9261.578481] Lustre: Evicted from MGS (at 192.168.206.104@tcp) after server handle changed from 0x5d57321c3ecfe8fe to 0x5d57321c3ecfeb74 [ 9261.608579] Lustre: MGC192.168.206.104@tcp: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 9266.116308] Lustre: lustre-MDT0000-mdc-ffff8da0441f3800: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 9271.216350] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9272.376225] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9275.284504] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9276.905612] Lustre: lustre-MDT0000-mdc-ffff8da0441f3800: Connection to lustre-MDT0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9293.280063] Lustre: 214943:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788805643/real 1788805643] req@000000007956ff21 x1875698450972288/t0(0) o400->MGC192.168.206.104@tcp@192.168.206.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1788805659 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9293.308816] LustreError: MGC192.168.206.104@tcp: Connection to MGS (at 192.168.206.104@tcp) was lost; in progress operations using this service will fail [ 9293.325771] Lustre: Evicted from MGS (at 192.168.206.104@tcp) after server handle changed from 0x5d57321c3ecfeb74 to 0x5d57321c3ecfee84 [ 9293.335167] Lustre: MGC192.168.206.104@tcp: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 9298.385706] Lustre: lustre-MDT0000-mdc-ffff8da0441f3800: Connection restored to 192.168.206.104@tcp (at 192.168.206.104@tcp) [ 9302.373721] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9303.520520] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9306.311909] Lustre: Unmounted lustre-client [ 9356.730486] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9361.120854] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9374.911558] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9385.998412] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 9387.455687] Lustre: Unmounted lustre-client [ 9413.984799] Key type lgssc unregistered [ 9414.178839] LNet: 225510:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9414.189191] LNetError: 225510:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9414.207971] LNet: Removed LNI 192.168.206.4@tcp [ 9414.730627] Key type .llcrypt unregistered [ 9414.734501] Key type ._llcrypt unregistered [ 9425.568137] Key type ._llcrypt registered [ 9425.570326] Key type .llcrypt registered [ 9426.511415] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 14:29:51 (1788805791) [ 9429.182256] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9429.205372] alg: No test for adler32 (adler32-zlib) [ 9430.192724] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 9430.368808] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 9432.017392] Key type lgssc registered [ 9432.848891] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9467.222250] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9471.139657] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9485.413604] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9496.079395] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 9500.288368] Lustre: Unmounted lustre-client [ 9544.629837] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9547.299237] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9558.253611] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9558.588115] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 9565.470471] Lustre: Unmounted lustre-client [ 9609.364809] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9612.455927] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9624.481303] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9624.774178] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 9625.715136] Lustre: Unmounted lustre-client [ 9645.726618] Key type lgssc unregistered [ 9645.869955] LNet: 232539:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9645.875700] LNetError: 232539:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9645.886694] LNet: Removed LNI 192.168.206.4@tcp [ 9646.285478] Key type .llcrypt unregistered [ 9646.287842] Key type ._llcrypt unregistered [ 9655.528859] Key type ._llcrypt registered [ 9655.531267] Key type .llcrypt registered [ 9656.293771] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 14:33:41 (1788806021) [ 9658.141913] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9658.152446] alg: No test for adler32 (adler32-zlib) [ 9659.075516] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 9659.231869] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 9660.855421] Key type lgssc registered [ 9661.549331] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9685.276604] Key type lgssc unregistered [ 9685.413456] LNet: 234855:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9685.417109] LNetError: 234855:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9685.434302] LNet: Removed LNI 192.168.206.4@tcp [ 9685.728405] Key type .llcrypt unregistered [ 9685.729846] Key type ._llcrypt unregistered [ 9697.584111] Key type ._llcrypt registered [ 9697.601040] Key type .llcrypt registered [ 9697.753632] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9697.760725] alg: No test for adler32 (adler32-zlib) [ 9698.690871] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 9698.832741] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 9700.447560] Key type lgssc registered [ 9701.224213] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9742.107947] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9744.836729] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9755.107340] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9787.667270] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 9788.394551] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 14:35:53 (1788806153) [ 9804.217837] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9807.116588] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9818.196981] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9830.312154] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9831.702334] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 9837.027227] Lustre: lustre-OST0001-osc-ffff8da053144000: Connection to lustre-OST0001 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9840.590738] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9850.883077] Lustre: Unmounted lustre-client [ 9885.028500] Key type lgssc unregistered [ 9885.202236] LNet: 241944:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9885.212195] LNetError: 241944:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9885.229946] LNet: Removed LNI 192.168.206.4@tcp [ 9885.589658] Key type .llcrypt unregistered [ 9885.592252] Key type ._llcrypt unregistered [ 9900.186478] Key type ._llcrypt registered [ 9900.188087] Key type .llcrypt registered [ 9900.808806] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 14:37:46 (1788806266) [ 9907.513477] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9907.523852] alg: No test for adler32 (adler32-zlib) [ 9908.454406] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [ 9908.606115] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [ 9910.231987] Key type lgssc registered [ 9910.900316] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9936.967041] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9939.744305] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9953.560497] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 14:38:39 (1788806319) [ 9968.283566] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9970.926418] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9980.793762] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9982.068996] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [ 9988.794520] Lustre: Unmounted lustre-client [10050.511104] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10053.110104] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10089.066959] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10094.587773] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [10095.140889] Lustre: Unmounted lustre-client [10113.427747] Key type lgssc unregistered [10113.571224] LNet: 249610:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10113.574529] LNetError: 249610:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10113.583757] LNet: Removed LNI 192.168.206.4@tcp [10113.884292] Key type .llcrypt unregistered [10113.886524] Key type ._llcrypt unregistered [10125.312563] Key type ._llcrypt registered [10125.314648] Key type .llcrypt registered [10125.460133] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10125.467157] alg: No test for adler32 (adler32-zlib) [10126.365179] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [10126.482527] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [10128.079211] Key type lgssc registered [10128.626920] Lustre: Echo OBD driver; http://www.lustre.org/ [10167.583213] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10169.786558] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10179.414193] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10204.122393] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [10204.831788] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 14:42:50 (1788806570) [10217.727909] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10219.870693] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10228.601078] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10235.389156] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [10236.236285] Lustre: Unmounted lustre-client [10254.079542] Key type lgssc unregistered [10254.224520] LNet: 256221:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10254.228361] LNetError: 256221:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10254.240588] LNet: Removed LNI 192.168.206.4@tcp [10254.526569] Key type .llcrypt unregistered [10254.528269] Key type ._llcrypt unregistered [10260.153831] Key type ._llcrypt registered [10260.155052] Key type .llcrypt registered [10260.650484] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [10261.237417] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 14:43:46 (1788806626) [10264.528422] Key type .llcrypt unregistered [10264.530080] Key type ._llcrypt unregistered [10267.677603] Key type ._llcrypt registered [10267.679375] Key type .llcrypt registered [10267.878758] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10267.885100] alg: No test for adler32 (adler32-zlib) [10268.758184] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [10268.855708] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [10270.455294] Key type lgssc registered [10270.993287] Lustre: Echo OBD driver; http://www.lustre.org/ [10292.790405] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10303.478992] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [10304.126784] Lustre: Unmounted lustre-client [10322.174377] Key type lgssc unregistered [10322.301529] LNet: 259655:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10322.304462] LNetError: 259655:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10322.311667] LNet: Removed LNI 192.168.206.4@tcp [10322.570268] Key type .llcrypt unregistered [10322.571897] Key type ._llcrypt unregistered [10328.682134] Key type ._llcrypt registered [10328.683495] Key type .llcrypt registered [10329.260560] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 14:44:54 (1788806694) [10330.231596] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10330.269797] alg: No test for adler32 (adler32-zlib) [10331.178717] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [10331.308775] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [10332.919275] Key type lgssc registered [10333.435809] Lustre: Echo OBD driver; http://www.lustre.org/ [10395.745896] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10408.082395] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10410.065326] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10411.250848] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [10411.832823] Lustre: Unmounted lustre-client [10429.769782] Key type lgssc unregistered [10429.908077] LNet: 263179:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10429.912840] LNetError: 263179:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10429.926368] LNet: Removed LNI 192.168.206.4@tcp [10430.245082] Key type .llcrypt unregistered [10430.246415] Key type ._llcrypt unregistered [10435.973124] Key type ._llcrypt registered [10435.974305] Key type .llcrypt registered [10436.453768] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 14:46:42 (1788806802) [10437.303446] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10437.333376] alg: No test for adler32 (adler32-zlib) [10438.234573] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [10438.343955] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [10439.943204] Key type lgssc registered [10440.426275] Lustre: Echo OBD driver; http://www.lustre.org/ [10461.269289] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10463.447963] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10471.359767] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10477.048736] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [10482.146789] Lustre: lustre-MDT0000-mdc-ffff8da0580eb000: Connection to lustre-MDT0000 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [10484.602816] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10484.614051] LustreError: 266320:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [10484.740921] LustreError: MGC192.168.206.104@tcp: Connection to MGS (at 192.168.206.104@tcp) was lost; in progress operations using this service will fail [10484.754038] Lustre: Unmounted lustre-client [10495.964898] Key type lgssc unregistered [10496.097099] LNet: 266732:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10496.101596] LNetError: 266732:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10496.110919] LNet: Removed LNI 192.168.206.4@tcp [10496.399538] Key type .llcrypt unregistered [10496.400958] Key type ._llcrypt unregistered [10502.561025] Key type ._llcrypt registered [10502.562289] Key type .llcrypt registered [10503.121678] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 14:47:48 (1788806868) [10504.016859] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10504.027465] alg: No test for adler32 (adler32-zlib) [10504.896982] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [10504.992654] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [10506.575360] Key type lgssc registered [10507.050329] Lustre: Echo OBD driver; http://www.lustre.org/ [10527.584238] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10529.535000] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10536.858866] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10542.582510] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [10547.684923] Lustre: lustre-MDT0001-mdc-ffff8da0449cd000: Connection to lustre-MDT0001 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [10550.258059] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [10550.653629] Lustre: Unmounted lustre-client [10561.507865] Key type lgssc unregistered [10561.621661] LNet: 270297:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10561.624443] LNetError: 270297:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10561.633300] LNet: Removed LNI 192.168.206.4@tcp [10561.876726] Key type .llcrypt unregistered [10561.878831] Key type ._llcrypt unregistered [10567.045253] Key type ._llcrypt registered [10567.046238] Key type .llcrypt registered [10567.518477] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 14:48:53 (1788806933) [10573.316145] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10573.325496] alg: No test for adler32 (adler32-zlib) [10574.191361] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [10574.284266] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [10575.863139] Key type lgssc registered [10576.227895] Lustre: Echo OBD driver; http://www.lustre.org/ [10616.801728] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10623.464333] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [10641.378869] Lustre: lustre-MDT0001-mdc-ffff8da0600c7800: Connection to lustre-MDT0001 (at 192.168.206.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [10648.155246] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10658.427198] Lustre: Unmounted lustre-client [10684.181862] Key type lgssc unregistered [10684.300444] LNet: 276060:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10684.303511] LNetError: 276060:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10684.314788] LNet: Removed LNI 192.168.206.4@tcp [10684.581716] Key type .llcrypt unregistered [10684.583819] Key type ._llcrypt unregistered [10690.284064] Key type ._llcrypt registered [10690.285399] Key type .llcrypt registered [10690.784531] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 14:50:56 (1788807056) [10691.374219] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [10691.949909] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 14:50:57 (1788807057) [10692.557412] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [10693.220360] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 14:50:58 (1788807058) [10693.842637] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [10694.478995] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 14:51:00 (1788807060) [10695.087236] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [10695.729933] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 14:51:01 (1788807061) [10696.377626] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [10697.029376] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 14:51:02 (1788807062) [10700.534752] Key type .llcrypt unregistered [10700.537179] Key type ._llcrypt unregistered [10703.145090] Key type ._llcrypt registered [10703.146688] Key type .llcrypt registered [10703.293567] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10703.299472] alg: No test for adler32 (adler32-zlib) [10704.156450] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [10704.246957] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [10705.831272] Key type lgssc registered [10706.213740] Lustre: Echo OBD driver; http://www.lustre.org/ [10736.844397] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10739.097579] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10748.332330] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10749.514647] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [10750.001364] Lustre: Unmounted lustre-client [10773.881639] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 14:52:19 (1788807139) [10786.567717] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10788.588434] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10809.538668] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10825.209680] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [10825.593159] Lustre: Unmounted lustre-client [10855.995421] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 14:53:41 (1788807221) [10865.055313] LNet: 1 local NIs in recovery (showing 1): 192.168.206.4@tcp [11443.380468] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11445.133151] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11464.733743] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11512.693147] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 15:04:38 (1788807878) [11516.560631] Key type lgssc unregistered [11516.677352] LNet: 289543:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11516.680975] LNetError: 289543:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11516.692293] LNet: Removed LNI 192.168.206.4@tcp [11516.938464] Key type .llcrypt unregistered [11516.939877] Key type ._llcrypt unregistered [11591.180882] Key type ._llcrypt registered [11591.183077] Key type .llcrypt registered [11591.327182] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11591.332277] alg: No test for adler32 (adler32-zlib) [11592.188505] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [11592.281668] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [11593.863221] Key type lgssc registered [11594.216018] Lustre: Echo OBD driver; http://www.lustre.org/ [11624.990515] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11626.747604] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11634.393594] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11646.711167] Key type lgssc unregistered [11646.819338] LNet: 293209:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11646.821870] LNetError: 293209:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11646.829480] LNet: Removed LNI 192.168.206.4@tcp [11647.042735] Key type .llcrypt unregistered [11647.044052] Key type ._llcrypt unregistered [11669.116719] Key type ._llcrypt registered [11669.117970] Key type .llcrypt registered [11669.575307] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 15:07:15 (1788808035) [11676.030258] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11676.070571] alg: No test for adler32 (adler32-zlib) [11676.924783] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [11677.026296] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [11678.599218] Key type lgssc registered [11678.944395] Lustre: Echo OBD driver; http://www.lustre.org/ [11695.161314] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 15:07:40 (1788808060) [11698.955411] Key type lgssc unregistered [11699.077440] LNet: 296748:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11699.079896] LNetError: 296748:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11699.089399] LNet: Removed LNI 192.168.206.4@tcp [11699.325218] Key type .llcrypt unregistered [11699.326490] Key type ._llcrypt unregistered [11702.735032] Key type ._llcrypt registered [11702.738534] Key type .llcrypt registered [11702.907295] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11702.911698] alg: No test for adler32 (adler32-zlib) [11703.764954] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [11703.857374] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [11705.439222] Key type lgssc registered [11705.810823] Lustre: Echo OBD driver; http://www.lustre.org/ [11725.838567] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11727.535132] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11735.154530] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11818.254919] LNet: Added LNI 192.168.206.4@tcp50 [8/256/0/180] [11819.048947] LNet: Removed LNI 192.168.206.4@tcp [11820.460667] Lustre: 301098:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8da0446a1000: config has no valid NIDs, force dynamic NIDs [11821.506584] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [11821.557142] Lustre: Unmounted lustre-client [11822.495715] Key type lgssc unregistered [11822.641858] LNet: 301357:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11822.644387] LNetError: 301357:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11822.653322] LNet: Removed LNI 192.168.206.4@tcp50 [11822.879366] Key type .llcrypt unregistered [11822.880474] Key type ._llcrypt unregistered [11832.675933] Key type ._llcrypt registered [11832.677630] Key type .llcrypt registered [11832.873838] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11832.879107] alg: No test for adler32 (adler32-zlib) [11833.745958] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [11833.841093] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [11835.431207] Key type lgssc registered [11835.839691] Lustre: Echo OBD driver; http://www.lustre.org/ [11864.553346] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11866.407330] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11868.770465] LNet: Added LNI 192.168.206.4@tcp50 [8/256/0/180] [11869.033557] LNet: Removed LNI 192.168.206.4@tcp [11870.123739] Lustre: 304036:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8da050254000: config has no valid NIDs, force dynamic NIDs [11871.173695] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [11871.335111] Lustre: Unmounted lustre-client [11890.266767] Key type lgssc unregistered [11890.399854] LNet: 304903:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11890.402504] LNetError: 304903:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11890.409493] LNet: Removed LNI 192.168.206.4@tcp50 [11890.613039] Key type .llcrypt unregistered [11890.614696] Key type ._llcrypt unregistered [11893.903767] Key type ._llcrypt registered [11893.904903] Key type .llcrypt registered [11894.348900] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 15:10:59 (1788808259) [11900.374626] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11900.404074] alg: No test for adler32 (adler32-zlib) [11901.247859] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [11901.323251] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [11902.895205] Key type lgssc registered [11903.240527] Lustre: Echo OBD driver; http://www.lustre.org/ [11929.783180] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11931.386086] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11939.038912] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11957.665113] Key type lgssc unregistered [11957.797473] LNet: 309626:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11957.799825] LNetError: 309626:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11957.805471] LNet: Removed LNI 192.168.206.4@tcp [11958.033201] Key type .llcrypt unregistered [11958.034245] Key type ._llcrypt unregistered [11961.658834] Key type ._llcrypt registered [11961.660853] Key type .llcrypt registered [11962.142469] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 15:12:07 (1788808327) [11962.886429] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11962.934754] alg: No test for adler32 (adler32-zlib) [11963.800245] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [11963.885270] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [11965.463214] Key type lgssc registered [11965.823632] Lustre: Echo OBD driver; http://www.lustre.org/ [11983.462195] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11985.293293] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11991.991858] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12002.289751] Lustre: Mounted lustre-client - version 2.17.58_39_g569731d [12022.286827] Lustre: Mounted fs15246-client - version 2.17.58_39_g569731d [12026.959274] Lustre: Unmounted fs15246-client [12039.584724] Lustre: Unmounted lustre-client [12064.702859] Key type lgssc unregistered [12064.822482] LNet: 314459:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12064.827614] LNetError: 314459:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12064.835577] LNet: Removed LNI 192.168.206.4@tcp [12065.067835] Key type .llcrypt unregistered [12065.069190] Key type ._llcrypt unregistered [12068.881033] Key type ._llcrypt registered [12068.882131] Key type .llcrypt registered [12069.344591] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 15:13:54 (1788808434) [12069.974278] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12069.985868] alg: No test for adler32 (adler32-zlib) [12070.850966] Lustre: Lustre: Build Version: 2.17.58_39_g569731d [12070.954225] LNet: Added LNI 192.168.206.4@tcp [8/256/0/180] [12072.543208] Key type lgssc registered [12072.923673] Lustre: Echo OBD driver; http://www.lustre.org/ [12117.643872] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12119.561366] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12128.234739] Lustre: DEBUG MARKER: oleg604-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12169.805608] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 11913 sec ========= 15:15:35 (1788808535) [12170.401769] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 15:15:35 (1788808535) === [12171.480642] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 15:15:37 (1788808537) === [12183.215380] Key type lgssc unregistered [12183.341445] LNet: 323680:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12183.343844] LNetError: 323680:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12183.351888] LNet: Removed LNI 192.168.206.4@tcp [12183.621771] Key type .llcrypt unregistered [12183.622839] Key type ._llcrypt unregistered