[ 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 433115689 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 2432MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001012] APIC: Switch to symmetric I/O mode setup [ 0.003052] x2apic enabled [ 0.004007] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.008000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008019] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009013] pid_max: default: 32768 minimum: 301 [ 0.011091] LSM: Security Framework initializing [ 0.012057] Yama: becoming mindful. [ 0.013037] SELinux: Initializing. [ 0.014066] *** VALIDATE selinux *** [ 0.021749] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.025605] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.026143] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027113] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028101] *** VALIDATE tmpfs *** [ 0.030179] *** VALIDATE proc *** [ 0.031189] *** VALIDATE cgroup *** [ 0.032008] *** VALIDATE cgroup2 *** [ 0.033242] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.034136] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.035008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.036027] Spectre V2 : User space: Vulnerable [ 0.037007] Speculative Store Bypass: Vulnerable [ 0.040440] debug: unmapping init [mem 0xffffffffabc59000-0xffffffffabc60fff] [ 0.042165] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043570] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044019] ... version: 2 [ 0.045009] ... bit width: 48 [ 0.046009] ... generic registers: 4 [ 0.047009] ... value mask: 0000ffffffffffff [ 0.048009] ... max period: 00007fffffffffff [ 0.049009] ... fixed-purpose events: 3 [ 0.050008] ... event mask: 000000070000000f [ 0.051287] rcu: Hierarchical SRCU implementation. [ 0.053308] smp: Bringing up secondary CPUs ... [ 0.054497] x86: Booting SMP configuration: [ 0.055019] .... node #0, CPUs: #1 #2 #3 [ 0.058071] smp: Brought up 1 node, 4 CPUs [ 0.060010] smpboot: Max logical packages: 1 [ 0.061012] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.143437] node 0 deferred pages initialised in 78ms [ 0.146008] devtmpfs: initialized [ 0.147276] x86/mm: Memory block size: 128MB [ 0.150935] gcov: version magic: 0x41383552 [ 0.153220] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.156089] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.159407] pinctrl core: initialized pinctrl subsystem [ 0.160161] [ 0.160567] ************************************************************* [ 0.163012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.165012] ** ** [ 0.168010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.170010] ** ** [ 0.172012] ** This means that this kernel is built to expose internal ** [ 0.174013] ** IOMMU data structures, which may compromise security on ** [ 0.177012] ** your system. ** [ 0.179011] ** ** [ 0.181012] ** If you see this message and you are not debugging the ** [ 0.184013] ** kernel, report this immediately to your vendor! ** [ 0.186012] ** ** [ 0.188010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.191013] ************************************************************* [ 0.194139] NET: Registered protocol family 16 [ 0.195409] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.198053] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.200050] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.203078] cpuidle: using governor menu [ 0.204680] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.206542] PCI: Using configuration type 1 for base access [ 0.208133] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.218081] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.220037] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.224044] cryptd: max_cpu_qlen set to 1000 [ 0.227188] ACPI: Added _OSI(Module Device) [ 0.229013] ACPI: Added _OSI(Processor Device) [ 0.230009] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.231012] ACPI: Added _OSI(Processor Aggregator Device) [ 0.237059] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.242429] ACPI: Interpreter enabled [ 0.243071] ACPI: PM: (supports S0 S3 S4 S5) [ 0.245014] ACPI: Using IOAPIC for interrupt routing [ 0.246124] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.249385] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.260000] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.263032] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.265017] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.267089] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.271109] acpiphp: Slot [2] registered [ 0.272124] acpiphp: Slot [5] registered [ 0.273127] acpiphp: Slot [6] registered [ 0.274116] acpiphp: Slot [3] registered [ 0.275112] acpiphp: Slot [4] registered [ 0.277093] acpiphp: Slot [7] registered [ 0.278108] acpiphp: Slot [8] registered [ 0.279081] acpiphp: Slot [9] registered [ 0.280077] acpiphp: Slot [10] registered [ 0.281074] acpiphp: Slot [11] registered [ 0.282091] acpiphp: Slot [12] registered [ 0.283136] acpiphp: Slot [13] registered [ 0.285095] acpiphp: Slot [14] registered [ 0.286099] acpiphp: Slot [15] registered [ 0.287075] acpiphp: Slot [16] registered [ 0.288081] acpiphp: Slot [17] registered [ 0.290089] acpiphp: Slot [18] registered [ 0.291067] acpiphp: Slot [19] registered [ 0.292104] acpiphp: Slot [20] registered [ 0.294092] acpiphp: Slot [21] registered [ 0.295113] acpiphp: Slot [22] registered [ 0.297128] acpiphp: Slot [23] registered [ 0.298097] acpiphp: Slot [24] registered [ 0.300107] acpiphp: Slot [25] registered [ 0.301109] acpiphp: Slot [26] registered [ 0.303116] acpiphp: Slot [27] registered [ 0.304090] acpiphp: Slot [28] registered [ 0.306123] acpiphp: Slot [29] registered [ 0.307115] acpiphp: Slot [30] registered [ 0.309116] acpiphp: Slot [31] registered [ 0.310143] PCI host bridge to bus 0000:00 [ 0.311018] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.314021] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.316022] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.319025] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.322031] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.325030] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.326214] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.328906] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.332334] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.339987] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.344041] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.346018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.348014] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.349012] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.352072] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.353622] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.356035] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.358654] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.361012] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.368014] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.372012] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.376015] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.382014] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.389015] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.405020] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.414883] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.420012] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.425013] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.436013] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.446028] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.449530] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.452470] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.455346] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.457333] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.462088] iommu: Default domain type: Passthrough [ 0.464431] SCSI subsystem initialized [ 0.466162] ACPI: bus type USB registered [ 0.468107] usbcore: registered new interface driver usbfs [ 0.470078] usbcore: registered new interface driver hub [ 0.472073] usbcore: registered new device driver usb [ 0.474148] pps_core: LinuxPPS API ver. 1 registered [ 0.476011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.479054] PTP clock support registered [ 0.480149] EDAC MC: Ver: 3.0.0 [ 0.482145] PCI: Using ACPI for IRQ routing [ 0.483777] NetLabel: Initializing [ 0.484010] NetLabel: domain hash size = 128 [ 0.485010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.486131] NetLabel: unlabeled traffic allowed by default [ 0.487076] vgaarb: loaded [ 0.488291] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.491033] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.501051] clocksource: Switched to clocksource kvm-clock [ 0.610469] VFS: Disk quotas dquot_6.6.0 [ 0.612242] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.615791] *** VALIDATE ramfs *** [ 0.617517] *** VALIDATE hugetlbfs *** [ 0.619542] pnp: PnP ACPI init [ 0.622330] pnp: PnP ACPI: found 6 devices [ 0.645663] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.649138] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.651058] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.652976] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.655012] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.657043] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.659222] NET: Registered protocol family 2 [ 0.661816] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.666034] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.668893] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.673559] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.676349] TCP: Hash tables configured (established 65536 bind 65536) [ 0.678888] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.681741] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.684023] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.687516] NET: Registered protocol family 1 [ 0.689732] RPC: Registered named UNIX socket transport module. [ 0.691511] RPC: Registered udp transport module. [ 0.692935] RPC: Registered tcp transport module. [ 0.694358] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.696208] NET: Registered protocol family 44 [ 0.697571] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.699232] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.700922] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.702803] PCI: CLS 0 bytes, default 64 [ 0.704832] Unpacking initramfs... [ 2.147949] debug: unmapping init [mem 0xffff9b313cc64000-0xffff9b313ffcffff] [ 2.151963] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.154289] software IO TLB: mapped [mem 0x00000000b8c64000-0x00000000bcc64000] (64MB) [ 2.158158] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.665496] Initialise system trusted keyrings [ 2.667579] Key type blacklist registered [ 2.669776] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.678693] zbud: loaded [ 2.681799] *** VALIDATE nfs *** [ 2.683163] *** VALIDATE nfs4 *** [ 2.685270] pstore: using deflate compression [ 2.689423] Platform Keyring initialized [ 2.789426] NET: Registered protocol family 38 [ 2.791879] Key type asymmetric registered [ 2.794480] Asymmetric key parser 'x509' registered [ 2.796118] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.807689] io scheduler mq-deadline registered [ 2.809475] io scheduler kyber registered [ 2.811104] io scheduler bfq registered [ 2.813408] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.816975] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.819877] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.822790] ACPI: Power Button [PWRF] [ 2.828178] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.835041] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.846523] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.876467] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.902860] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.908047] Non-volatile memory driver v1.3 [ 2.909574] Linux agpgart interface v0.103 [ 2.943422] virtio_blk virtio1: [vda] 146680 512-byte logical blocks (75.1 MB/71.6 MiB) [ 2.946103] vda: detected capacity change from 0 to 75100160 [ 2.961824] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.965378] vdb: detected capacity change from 0 to 1073741824 [ 2.974676] libphy: Fixed MDIO Bus: probed [ 2.983767] usbcore: registered new interface driver usbserial_generic [ 2.986310] usbserial: USB Serial support registered for generic [ 2.988060] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.991699] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.993085] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.995358] mousedev: PS/2 mouse device common for all mice [ 2.998469] rtc_cmos 00:05: RTC can wake from S4 [ 2.998514] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.003100] rtc_cmos 00:05: registered as rtc0 [ 3.005487] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.007974] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.008346] intel_pstate: CPU model not supported [ 3.013028] hid: raw HID events driver (C) Jiri Kosina [ 3.015045] usbcore: registered new interface driver usbhid [ 3.015189] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.016496] usbhid: USB HID core driver [ 3.019619] drop_monitor: Initializing network drop monitor service [ 3.021460] Initializing XFRM netlink socket [ 3.023445] NET: Registered protocol family 10 [ 3.026783] Segment Routing with IPv6 [ 3.028336] NET: Registered protocol family 17 [ 3.030551] mpls_gso: MPLS GSO support [ 3.036282] RAS: Correctable Errors collector initialized. [ 3.038554] AVX version of gcm_enc/dec engaged. [ 3.040367] AES CTR mode by8 optimization enabled [ 3.108884] sched_clock: Marking stable (3108863874, 0)->(3981829628, -872965754) [ 3.112040] registered taskstats version 1 [ 3.114317] Loading compiled-in X.509 certificates [ 3.116309] zswap: loaded using pool lzo/zbud [ 3.138560] Key type big_key registered [ 3.149761] Key type encrypted registered [ 3.151364] ima: No TPM chip found, activating TPM-bypass! [ 3.153186] ima: Allocated hash algorithm: sha1 [ 3.155027] ima: No architecture policies found [ 3.156532] evm: Initialising EVM extended attributes: [ 3.158253] evm: security.selinux [ 3.159091] evm: security.ima [ 3.162896] evm: security.capability [ 3.164138] evm: HMAC attrs: 0x1 [ 3.166332] rtc_cmos 00:05: setting system clock to 2026-08-27 10:22:35 UTC (1787826155) [ 3.172205] debug: unmapping init [mem 0xffffffffacc03000-0xffffffffacdfffff] [ 3.175016] debug: unmapping init [mem 0xffffffffab982000-0xffffffffabc58fff] [ 3.183078] Write protecting the kernel read-only data: 28672k [ 3.187189] debug: unmapping init [mem 0xffffffffaa003000-0xffffffffaa1fffff] [ 3.190643] debug: unmapping init [mem 0xffffffffaa914000-0xffffffffaa9fffff] [ 3.229882] 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.240102] systemd[1]: Detected virtualization kvm. [ 3.243249] systemd[1]: Detected architecture x86-64. [ 3.245281] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.272886] systemd[1]: No hostname configured. [ 3.274443] systemd[1]: Set hostname to . [ 3.276400] random: systemd: uninitialized urandom read (16 bytes read) [ 3.278358] systemd[1]: Initializing machine ID from random generator. [ 3.326207] random: ln: uninitialized urandom read (6 bytes read) [ 3.411935] random: systemd: uninitialized urandom read (16 bytes read) [ 3.414579] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.420224] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 3.424095] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ OK ] Reached target Paths. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Swap. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket. Starting Create Volatile Files and Directories... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. Starting Journal Service... Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.093801] device-mapper: uevent: version 1.0.3 [ 4.096591] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.875702] virtio_net virtio0 ens2: renamed from eth0 [ 4.914378] scsi host0: ata_piix [ 4.963820] scsi host1: ata_piix [ 4.966049] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.968208] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.754465] dracut-initqueue[584]: RTNETLINK answers: File exists [ 9.669226] random: crng init done [ 9.672013] 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.184712] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target 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 target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Local File Systems. [ 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 Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.268439] printk: systemd: 24 output lines suppressed due to ratelimiting [ 11.521336] SELinux: Disabled at runtime. [ 11.582720] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.591680] systemd[1]: Detected virtualization kvm. [ 11.593576] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.119782] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.123072] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.127894] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.132109] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.136156] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.146334] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.150496] systemd[1]: proc-sys-fs-binfmt_misc.automount: Refusing to start, unit to trigger not loaded. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice User and Session Slice. [ OK ] Created slice system-getty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Slices. [ OK ] Listening on udev Control Socket. Mounting POSIX Message Queue File System... [ OK ] Listening on udev Kernel Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Mounting Huge Pages File System... Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting Kernel Debug File System... [ OK ] Reached target rpc_pipefs.target. Starting Apply Kernel Variables... Starting udev Coldplug all Devices... [ OK ] Reached target Local Encrypted Volumes. [ 12.251203] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on Process Core Dump Socket. Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Initrd File Systems. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... [ 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 ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.540357] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.868701] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.904434] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.015323] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.028806] EDAC sbridge: Ver: 1.1.2 [ 14.041687] Key type dns_resolver registered [ 14.344247] NFS: Registering the id_resolver key type [ 14.346741] Key type id_resolver registered [ 14.348487] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... Starting Restore /run/initramfs on shutdown... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started 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 oleg633-client login: [ 50.433502] libcfs: loading out-of-tree module taints kernel. [ 50.684479] Key type ._llcrypt registered [ 50.690657] Key type .llcrypt registered [ 51.313921] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 51.343816] alg: No test for adler32 (adler32-zlib) [ 52.823470] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 53.898266] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 55.671380] Key type lgssc registered [ 57.739067] Lustre: Echo OBD driver; http://www.lustre.org/ [ 60.203827] hrtimer: interrupt took 1981461 ns [ 225.324182] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 230.526713] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 247.945287] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing check_logdir /tmp/testlogs/ [ 250.854159] Lustre: lustre-OST0000-osc-ffff9b31873cb800: disconnect after 23s idle [ 254.416331] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing yml_node [ 258.678380] Lustre: DEBUG MARKER: Client: 2.17.57.68 [ 261.274123] Lustre: DEBUG MARKER: MDS: 2.17.57.68 [ 263.757618] Lustre: DEBUG MARKER: OSS: 2.17.57.68 [ 265.448951] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Aug 27 06:26:56 EDT 2026 [ 284.275862] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 285.809248] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 288.784712] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 299.093661] Lustre: Unmounted lustre-client [ 417.947617] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 424.038673] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 449.872756] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 487.860625] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 06:30:38 (1787826638) [ 490.817663] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 492.940924] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 06:30:43 (1787826643) [ 528.783610] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 534.514116] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 553.872834] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 554.455814] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 566.929888] Lustre: Unmounted lustre-client [ 594.361938] Key type lgssc unregistered [ 594.572469] LNet: 15069:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 594.584808] LNetError: 15069:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 594.607736] LNet: Removed LNI 192.168.206.33@tcp [ 595.312161] Key type .llcrypt unregistered [ 595.317081] Key type ._llcrypt unregistered [ 609.648440] Key type ._llcrypt registered [ 609.651284] Key type .llcrypt registered [ 610.911887] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 06:32:41 (1787826761) [ 612.521429] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 612.551987] alg: No test for adler32 (adler32-zlib) [ 613.580549] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 613.795934] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 615.463440] Key type lgssc registered [ 616.421535] Lustre: Echo OBD driver; http://www.lustre.org/ [ 689.962690] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 775.877431] Lustre: Unmounted lustre-client [ 806.015128] Key type lgssc unregistered [ 806.270603] LNet: 18892:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 806.274559] LNetError: 18892:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 807.335162] LNet: Removed LNI 192.168.206.33@tcp [ 808.167654] Key type .llcrypt unregistered [ 808.170219] Key type ._llcrypt unregistered [ 819.401351] Key type ._llcrypt registered [ 819.403272] Key type .llcrypt registered [ 821.220293] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 06:36:11 (1787826971) [ 823.694515] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 823.716260] alg: No test for adler32 (adler32-zlib) [ 824.760377] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 824.964267] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 826.599154] Key type lgssc registered [ 827.597544] Lustre: Echo OBD driver; http://www.lustre.org/ [ 876.184073] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 881.619943] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 901.223777] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 904.214440] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 915.496802] Lustre: Unmounted lustre-client [ 942.735781] Key type lgssc unregistered [ 942.985984] LNet: 22494:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 942.991820] LNetError: 22494:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 943.003500] LNet: Removed LNI 192.168.206.33@tcp [ 943.577610] Key type .llcrypt unregistered [ 943.581068] Key type ._llcrypt unregistered [ 952.504736] Key type ._llcrypt registered [ 952.507956] Key type .llcrypt registered [ 953.858530] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 06:38:24 (1787827104) [ 955.712680] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 955.731045] alg: No test for adler32 (adler32-zlib) [ 956.758305] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 957.020740] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 958.671278] Key type lgssc registered [ 959.819593] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1006.286553] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1012.005796] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1035.568099] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1037.534924] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 1047.744384] Lustre: Unmounted lustre-client [ 1083.873267] Key type lgssc unregistered [ 1084.113315] LNet: 25686:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1084.123575] LNetError: 25686:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1084.138716] LNet: Removed LNI 192.168.206.33@tcp [ 1084.761931] Key type .llcrypt unregistered [ 1084.764653] Key type ._llcrypt unregistered [ 1098.882941] Key type ._llcrypt registered [ 1098.885783] Key type .llcrypt registered [ 1100.196783] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 06:40:51 (1787827251) [ 1102.172374] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1102.237083] alg: No test for adler32 (adler32-zlib) [ 1103.424719] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 1103.621890] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 1105.263424] Key type lgssc registered [ 1106.543837] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1160.268381] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1166.195987] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1189.240776] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1191.168672] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 1201.642708] Lustre: lustre-MDT0000-mdc-ffff9b3184aa8000: Connection to lustre-MDT0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1211.886499] Lustre: lustre-MDT0001-mdc-ffff9b3184aa8000: Connection to lustre-MDT0001 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1217.898115] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1223.135713] Lustre: 26645:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787827359/real 1787827359] req@000000000593c2a0 x1874672751745024/t0(0) o400->MGC192.168.206.133@tcp@192.168.206.133@tcp:26/25 lens 224/224 e 0 to 1 dl 1787827375 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1223.159842] LustreError: MGC192.168.206.133@tcp: Connection to MGS (at 192.168.206.133@tcp) was lost; in progress operations using this service will fail [ 1228.262880] Lustre: Unmounted lustre-client [ 1241.797950] Key type lgssc unregistered [ 1242.060397] LNet: 29347:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1242.076974] LNetError: 29347:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1242.090423] LNet: Removed LNI 192.168.206.33@tcp [ 1242.769751] Key type .llcrypt unregistered [ 1242.779100] Key type ._llcrypt unregistered [ 1256.680743] Key type ._llcrypt registered [ 1256.682779] Key type .llcrypt registered [ 1257.885884] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 06:43:28 (1787827408) [ 1259.988661] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1260.061537] alg: No test for adler32 (adler32-zlib) [ 1261.091973] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 1261.385721] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 1263.208469] Key type lgssc registered [ 1265.288501] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1316.385788] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1320.924359] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1338.909161] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1340.533645] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 1345.522079] Lustre: lustre-OST0000-osc-ffff9b3187f40000: Connection to lustre-OST0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1352.639469] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1362.983594] Lustre: Unmounted lustre-client [ 1390.638591] Key type lgssc unregistered [ 1390.870685] LNet: 32963:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1390.884554] LNetError: 32963:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1390.906429] LNet: Removed LNI 192.168.206.33@tcp [ 1391.631774] Key type .llcrypt unregistered [ 1391.634062] Key type ._llcrypt unregistered [ 1406.882713] Key type ._llcrypt registered [ 1406.884887] Key type .llcrypt registered [ 1408.082912] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 06:45:59 (1787827559) [ 1410.115619] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1410.197278] alg: No test for adler32 (adler32-zlib) [ 1411.319285] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 1411.527576] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 1413.207229] Key type lgssc registered [ 1414.149800] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1464.973276] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1472.129143] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1493.605318] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1495.213759] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 1502.773823] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1505.811962] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1517.433459] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-27 6h47m48s [ 1519.727468] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1526.256340] Lustre: lustre-MDT0000-mdc-ffff9b3184aa8800: Connection to lustre-MDT0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1529.804816] LustreError: 36755:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff9b3184aa8800: can't stat MDS #0: rc = -19 [ 1531.501156] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1538.543958] LustreError: MGC192.168.206.133@tcp: Connection to MGS (at 192.168.206.133@tcp) was lost; in progress operations using this service will fail [ 1538.576729] Lustre: Evicted from MGS (at 192.168.206.133@tcp) after server handle changed from 0xf3c192daa7484697 to 0xf3c192daa7484818 [ 1538.590579] Lustre: MGC192.168.206.133@tcp: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 1539.673678] LustreError: lustre-MDT0000-mdc-ffff9b3184aa8800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1539.713081] Lustre: lustre-MDT0000-mdc-ffff9b3184aa8800: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 1549.111636] Lustre: DEBUG MARKER: Wait for df (36755) ... [ 1550.910102] Lustre: DEBUG MARKER: done [ 1553.152301] Lustre: Unmounted lustre-client [ 1581.821861] Key type lgssc unregistered [ 1582.131788] LNet: 37774:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1582.150274] LNetError: 37774:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1582.171637] LNet: Removed LNI 192.168.206.33@tcp [ 1582.845135] Key type .llcrypt unregistered [ 1582.848632] Key type ._llcrypt unregistered [ 1614.682940] Key type ._llcrypt registered [ 1614.684746] Key type .llcrypt registered [ 1615.756307] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 06:49:26 (1787827766) [ 1618.359639] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1618.390033] alg: No test for adler32 (adler32-zlib) [ 1619.620586] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 1619.884506] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 1621.551341] Key type lgssc registered [ 1622.710096] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1675.583857] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1680.920870] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1702.642302] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1705.403958] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 1710.018510] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-27 6h51m01s [ 1711.510277] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1719.893777] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1722.552746] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1742.815167] Lustre: 41920:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787827874/real 1787827874] req@00000000b107494f x1874673293859584/t0(0) o101->lustre-MDT0000-mdc-ffff9b319858c000@192.168.206.133@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787827894 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1742.856606] Lustre: lustre-MDT0000-mdc-ffff9b319858c000: Connection to lustre-MDT0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1742.906983] Lustre: lustre-MDT0000-mdc-ffff9b319858c000: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 1764.236935] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1767.440582] Lustre: DEBUG MARKER: done [ 1770.905615] Lustre: Unmounted lustre-client [ 1798.397814] Key type lgssc unregistered [ 1798.682760] LNet: 42809:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1798.685981] LNetError: 42809:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1798.714231] LNet: Removed LNI 192.168.206.33@tcp [ 1799.326792] Key type .llcrypt unregistered [ 1799.329461] Key type ._llcrypt unregistered [ 1829.952527] Key type ._llcrypt registered [ 1829.955539] Key type .llcrypt registered [ 1831.343145] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 06:53:02 (1787827982) [ 1832.611314] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1834.292627] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 06:53:05 (1787827985) [ 1838.116705] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1838.224064] alg: No test for adler32 (adler32-zlib) [ 1839.306144] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 1839.529259] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 1841.231188] Key type lgssc registered [ 1842.543232] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1870.272894] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 06:53:40 (1787828020) [ 1903.095239] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1909.415989] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1930.129274] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1932.858552] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 1936.508854] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1940.078764] Lustre: Unmounted lustre-client [ 1957.697878] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2006.637771] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2013.564957] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2014.517206] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 2019.314567] Lustre: Unmounted lustre-client [ 2082.582962] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2088.387419] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2089.058320] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 2093.749291] Lustre: Unmounted lustre-client [ 2115.316538] Lustre: DEBUG MARKER: files compared the same [ 2137.023620] Key type lgssc unregistered [ 2137.284793] LNet: 50441:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2137.294256] LNetError: 50441:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2137.313094] LNet: Removed LNI 192.168.206.33@tcp [ 2137.903439] Key type .llcrypt unregistered [ 2137.905576] Key type ._llcrypt unregistered [ 2151.855308] Key type ._llcrypt registered [ 2151.857768] Key type .llcrypt registered [ 2153.124554] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 06:58:24 (1787828304) [ 2155.978219] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2155.991806] alg: No test for adler32 (adler32-zlib) [ 2157.106923] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 2157.373587] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 2159.039262] Key type lgssc registered [ 2160.254569] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2205.130764] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2210.002540] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2229.959801] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2232.520448] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 2236.471317] Lustre: Unmounted lustre-client [ 2270.131575] Key type lgssc unregistered [ 2270.338388] LNet: 54030:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2270.350379] LNetError: 54030:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2270.385197] LNet: Removed LNI 192.168.206.33@tcp [ 2271.053320] Key type .llcrypt unregistered [ 2271.055761] Key type ._llcrypt unregistered [ 2283.953476] Key type ._llcrypt registered [ 2283.956939] Key type .llcrypt registered [ 2284.814498] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 07:00:36 (1787828436) [ 2286.779359] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2286.847136] alg: No test for adler32 (adler32-zlib) [ 2287.836727] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 2288.154162] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 2289.847388] Key type lgssc registered [ 2290.819368] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2375.518466] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2406.543627] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2412.401485] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2442.496300] Key type lgssc unregistered [ 2442.749561] LNet: 57529:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2442.757285] LNetError: 57529:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2442.774828] LNet: Removed LNI 192.168.206.33@tcp [ 2443.449741] Key type .llcrypt unregistered [ 2443.453137] Key type ._llcrypt unregistered [ 2461.840612] Key type ._llcrypt registered [ 2461.842806] Key type .llcrypt registered [ 2463.820129] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 07:03:33 (1787828613) [ 2467.210866] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2467.226920] alg: No test for adler32 (adler32-zlib) [ 2468.267539] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 2468.482909] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 2470.160604] Key type lgssc registered [ 2471.371613] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2542.672865] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 2550.402701] Lustre: Unmounted lustre-client [ 2598.201350] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 07:05:49 (1787828749) [ 2714.914175] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2736.678227] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 2743.936787] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2743.943406] LustreError: 64007:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff9b3187346000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2743.968670] Lustre: 58516:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.133@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2754.245839] Lustre: Unmounted lustre-client [ 2799.041618] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 07:09:10 (1787828950) [ 2811.060695] Key type lgssc unregistered [ 2811.346517] LNet: 65222:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2811.355922] LNetError: 65222:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2811.379850] LNet: Removed LNI 192.168.206.33@tcp [ 2812.037821] Key type .llcrypt unregistered [ 2812.039971] Key type ._llcrypt unregistered [ 2824.010498] Key type ._llcrypt registered [ 2824.012619] Key type .llcrypt registered [ 2824.308931] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2824.333063] alg: No test for adler32 (adler32-zlib) [ 2825.413509] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 2825.663818] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 2827.359744] Key type lgssc registered [ 2828.421601] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2878.259217] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2884.569794] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2909.092952] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2910.926092] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 2915.318260] Lustre: Unmounted lustre-client [ 2944.251612] Key type lgssc unregistered [ 2944.680974] LNet: 68243:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2944.689896] LNetError: 68243:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2944.719550] LNet: Removed LNI 192.168.206.33@tcp [ 2945.503482] Key type .llcrypt unregistered [ 2945.505987] Key type ._llcrypt unregistered [ 2956.794264] Key type ._llcrypt registered [ 2956.812271] Key type .llcrypt registered [ 2957.425884] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2957.459404] alg: No test for adler32 (adler32-zlib) [ 2958.861153] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 2959.213569] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 2961.023227] Key type lgssc registered [ 2962.371509] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3083.447054] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3089.304839] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3109.926698] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3111.517990] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 3119.628026] Lustre: Unmounted lustre-client [ 3147.832775] Key type lgssc unregistered [ 3148.052329] LNet: 71682:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3148.062089] LNetError: 71682:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3149.093647] LNet: Removed LNI 192.168.206.33@tcp [ 3149.771431] Key type .llcrypt unregistered [ 3149.776085] Key type ._llcrypt unregistered [ 3166.344169] Key type ._llcrypt registered [ 3166.347083] Key type .llcrypt registered [ 3167.867521] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 07:15:18 (1787829318) [ 3170.430748] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3170.481927] alg: No test for adler32 (adler32-zlib) [ 3171.578492] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 3171.787409] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 3173.505400] Key type lgssc registered [ 3175.291320] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3226.276499] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3231.589203] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3252.677106] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3254.301784] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 3260.792541] Lustre: Unmounted lustre-client [ 3261.372600] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 3265.381573] Lustre: Unmounted lustre-client [ 3294.956650] Key type lgssc unregistered [ 3295.229912] LNet: 75373:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3295.241591] LNetError: 75373:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3295.267881] LNet: Removed LNI 192.168.206.33@tcp [ 3295.988599] Key type .llcrypt unregistered [ 3295.997607] Key type ._llcrypt unregistered [ 3308.979942] Key type ._llcrypt registered [ 3308.985693] Key type .llcrypt registered [ 3309.387857] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3309.424942] alg: No test for adler32 (adler32-zlib) [ 3310.587679] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 3310.999290] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 3312.744193] Key type lgssc registered [ 3314.130420] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3370.556337] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3377.122881] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3399.486258] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3401.164414] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 3406.067318] Lustre: Unmounted lustre-client [ 3434.529591] Key type lgssc unregistered [ 3434.875459] LNet: 78407:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3434.884241] LNetError: 78407:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3434.911642] LNet: Removed LNI 192.168.206.33@tcp [ 3435.949444] Key type .llcrypt unregistered [ 3435.952110] Key type ._llcrypt unregistered [ 3453.282895] Key type ._llcrypt registered [ 3453.285897] Key type .llcrypt registered [ 3455.023391] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 07:20:05 (1787829605) [ 3458.052836] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3458.196661] alg: No test for adler32 (adler32-zlib) [ 3459.340165] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 3459.798970] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 3461.543198] Key type lgssc registered [ 3462.944196] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3520.932906] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3527.917131] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3549.744353] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3551.532372] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 3564.413140] Lustre: lustre: root_squash is set to 0:0 [ 3571.759498] Lustre: lustre: nosquash_nids is cleared [ 3571.791169] Lustre: lustre: root_squash is set to 500:500 [ 3589.682979] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.33@tcp 192.168.0.[2,10]@tcp [ 3599.442666] Lustre: lustre: nosquash_nids set to 192.168.206.33/24@tcp [ 3603.644033] Lustre: Unmounted lustre-client [ 3634.579867] Key type lgssc unregistered [ 3634.882845] LNet: 82401:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3634.898532] LNetError: 82401:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3634.915464] LNet: Removed LNI 192.168.206.33@tcp [ 3635.815730] Key type .llcrypt unregistered [ 3635.818922] Key type ._llcrypt unregistered [ 3652.560849] Key type ._llcrypt registered [ 3652.562791] Key type .llcrypt registered [ 3653.830980] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 07:23:24 (1787829804) [ 3656.996808] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3659.396177] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 07:23:30 (1787829810) [ 3661.479832] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3661.629689] alg: No test for adler32 (adler32-zlib) [ 3662.837220] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 3663.007869] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 3664.655290] Key type lgssc registered [ 3665.806372] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3722.192862] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3728.640331] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3749.499752] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3751.010305] Lustre: lustre: root_squash is set to 500:500 [ 3751.050436] Lustre: lustre: nosquash_nids set to 192.168.206.33/24@tcp [ 3752.119967] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 3761.133856] Lustre: Unmounted lustre-client [ 3787.716756] Key type lgssc unregistered [ 3787.954839] LNet: 86365:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3787.962467] LNetError: 86365:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3787.974229] LNet: Removed LNI 192.168.206.33@tcp [ 3788.514544] Key type .llcrypt unregistered [ 3788.516713] Key type ._llcrypt unregistered [ 3802.109836] Key type ._llcrypt registered [ 3802.111055] Key type .llcrypt registered [ 3803.526561] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3804.984408] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 07:25:56 (1787829956) [ 3823.165342] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3823.193110] alg: No test for adler32 (adler32-zlib) [ 3824.234388] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 3824.552736] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 3826.271177] Key type lgssc registered [ 3827.627019] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3907.366450] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3913.272948] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3935.984356] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4016.766691] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4022.855927] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4047.090580] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4062.716638] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 4098.606777] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9b318447e800.ost_server_uuid 50 [ 4100.224421] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9b318447e800.ost_server_uuid in IDLE state after 0 sec [ 4100.853587] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 4104.847388] Lustre: Unmounted lustre-client [ 4106.840726] Lustre: Unmounted lustre-client [ 4159.140935] Key type lgssc unregistered [ 4159.404950] LNet: 94039:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4159.411663] LNetError: 94039:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4159.433965] LNet: Removed LNI 192.168.206.33@tcp [ 4160.183970] Key type .llcrypt unregistered [ 4160.186520] Key type ._llcrypt unregistered [ 4191.718114] Key type ._llcrypt registered [ 4191.720218] Key type .llcrypt registered [ 4192.910914] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 07:32:23 (1787830343) [ 4212.559563] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4212.668256] alg: No test for adler32 (adler32-zlib) [ 4213.773402] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 4214.013865] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 4215.711185] Key type lgssc registered [ 4216.965842] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4311.233571] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4319.144319] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4341.741534] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4344.465536] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 4364.768107] Lustre: 95401:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787830501/real 1787830501] req@0000000048ee51ae x1874676013864192/t0(0) o400->lustre-OST0000-osc-ffff9b3187cba800@192.168.206.133@tcp:28/4 lens 224/224 e 0 to 1 dl 1787830517 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4364.813464] Lustre: lustre-OST0000-osc-ffff9b3187cba800: Connection to lustre-OST0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4369.889620] Lustre: 95402:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787830506/real 1787830506] req@00000000bc26f7c8 x1874676013864704/t0(0) o400->lustre-OST0000-osc-ffff9b3187cba800@192.168.206.133@tcp:28/4 lens 224/224 e 0 to 1 dl 1787830522 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4375.007524] Lustre: 95401:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787830511/real 1787830511] req@00000000da08759f x1874676013865216/t0(0) o400->lustre-OST0000-osc-ffff9b3187cba800@192.168.206.133@tcp:28/4 lens 224/224 e 0 to 1 dl 1787830527 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4376.120654] Lustre: lustre-OST0000-osc-ffff9b3187cba800: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 4380.139748] Lustre: lustre-MDT0000-mdc-ffff9b3187cba800: Connection to lustre-MDT0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4381.279613] Lustre: 95402:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787830517/real 1787830517] req@00000000bbca2926 x1874676013865728/t0(0) o400->lustre-OST0000-osc-ffff9b3187cba800@192.168.206.133@tcp:28/4 lens 224/224 e 0 to 1 dl 1787830533 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4396.383443] Lustre: 95404:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787830532/real 1787830532] req@0000000012224ea2 x1874676013867648/t0(0) o400->MGC192.168.206.133@tcp@192.168.206.133@tcp:26/25 lens 224/224 e 0 to 1 dl 1787830548 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4396.419387] LustreError: MGC192.168.206.133@tcp: Connection to MGS (at 192.168.206.133@tcp) was lost; in progress operations using this service will fail [ 4396.461934] Lustre: Evicted from MGS (at 192.168.206.133@tcp) after server handle changed from 0x7eba1d17e6f3676b to 0x7eba1d17e6f36901 [ 4396.477345] Lustre: MGC192.168.206.133@tcp: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 4402.181485] Lustre: 98576:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.206.133@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 4411.576730] Lustre: lustre-MDT0000-mdc-ffff9b3187cba800: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 4417.019231] Lustre: Unmounted lustre-client [ 4443.530480] Key type lgssc unregistered [ 4443.750041] LNet: 99711:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4443.754179] LNetError: 99711:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4443.773142] LNet: Removed LNI 192.168.206.33@tcp [ 4444.348471] Key type .llcrypt unregistered [ 4444.350199] Key type ._llcrypt unregistered [ 4459.120687] Key type ._llcrypt registered [ 4459.124439] Key type .llcrypt registered [ 4460.446298] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 07:36:51 (1787830611) [ 4475.033108] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4475.073596] alg: No test for adler32 (adler32-zlib) [ 4476.146293] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 4476.428764] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 4478.143164] Key type lgssc registered [ 4479.121973] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4518.818958] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4623.811249] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4628.603572] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4651.351958] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4653.206726] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 4655.669112] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4657.554306] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 07:40:08 (1787830808) [ 4898.357158] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4908.707208] Lustre: Unmounted lustre-client [ 5034.151494] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5039.905808] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5061.116806] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5097.706770] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 07:47:29 (1787831249) [ 5183.233126] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5189.293225] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5214.517404] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5215.193408] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 5218.834387] Lustre: Unmounted lustre-client [ 5256.933622] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 07:50:07 (1787831407) [ 5335.614092] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5341.692473] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5363.712459] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5364.370633] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 5369.044461] Lustre: Unmounted lustre-client [ 5394.988362] Key type lgssc unregistered [ 5395.199994] LNet: 122729:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5395.212177] LNetError: 122729:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5395.231358] LNet: Removed LNI 192.168.206.33@tcp [ 5396.031312] Key type .llcrypt unregistered [ 5396.033485] Key type ._llcrypt unregistered [ 5409.658898] Key type ._llcrypt registered [ 5409.661480] Key type .llcrypt registered [ 5411.081770] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 07:52:41 (1787831561) [ 5413.419913] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5413.505542] alg: No test for adler32 (adler32-zlib) [ 5414.672475] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 5414.983753] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 5416.727193] Key type lgssc registered [ 5417.953849] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5467.902588] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5473.795429] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5494.481260] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5497.127872] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 5513.202290] Lustre: Unmounted lustre-client [ 5539.980517] Key type lgssc unregistered [ 5540.240492] LNet: 126323:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5540.268516] LNetError: 126323:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5540.299225] LNet: Removed LNI 192.168.206.33@tcp [ 5540.933163] Key type .llcrypt unregistered [ 5540.936957] Key type ._llcrypt unregistered [ 5553.874149] Key type ._llcrypt registered [ 5553.876243] Key type .llcrypt registered [ 5554.890443] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 07:55:06 (1787831706) [ 5557.113797] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5557.159222] alg: No test for adler32 (adler32-zlib) [ 5558.202702] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 5558.466767] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 5560.151576] Key type lgssc registered [ 5561.189557] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5606.368702] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5612.588764] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5632.173618] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5634.988461] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 5640.170101] Lustre: lustre-OST0000-osc-ffff9b31856c3000: Connection to lustre-OST0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5653.638961] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff9b31856c3000.ost_server_uuid 50 [ 5655.182353] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5666.295395] Lustre: Unmounted lustre-client [ 5688.731274] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 07:57:19 (1787831839) [ 5724.478527] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5729.689346] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5751.511249] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5776.797439] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5777.782643] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 5783.013353] Lustre: lustre-OST0000-osc-ffff9b3184aa9000: Connection to lustre-OST0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5806.355689] Lustre: Unmounted lustre-client [ 5858.678327] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 08:00:09 (1787832009) [ 5888.353306] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5893.643519] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5911.760889] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5930.042923] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5930.634184] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 5936.127084] Lustre: lustre-OST0000-osc-ffff9b3184aad000: Connection to lustre-OST0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5951.319791] Lustre: Unmounted lustre-client [ 5994.863032] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 08:02:25 (1787832145) [ 6083.049516] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6087.551430] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6109.925810] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6181.590649] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6188.547956] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6212.459454] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6246.284503] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 6292.630727] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6294.859079] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6299.165137] Lustre: Unmounted lustre-client [ 6333.326618] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 08:08:04 (1787832484) [ 6365.931067] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6371.608166] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6395.786321] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6434.086185] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6463.550182] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 6507.648267] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6509.106042] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6529.891282] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6540.280147] Lustre: Unmounted lustre-client [ 6594.528527] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 08:12:25 (1787832745) [ 6621.976483] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6627.467497] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6649.287640] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6649.934373] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 6673.515713] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6675.265224] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6692.683869] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9b31856c4800.ost_server_uuid 50 [ 6694.194772] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9b31856c4800.ost_server_uuid in IDLE state after 0 sec [ 6697.099637] Lustre: Unmounted lustre-client [ 6697.539658] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6697.550585] Lustre: Skipped 3 previous similar messages [ 6697.708555] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 6698.844307] LustreError: 149740:0:(sec.c:403:import_sec_validate_get()) import 0000000080f78422 (NEW) with no sec [ 6764.339886] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 08:15:14 (1787832914) [ 6795.969501] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6801.724880] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6821.963414] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6840.614994] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6841.090258] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6841.251673] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 6853.103892] Lustre: Unmounted lustre-client [ 6853.105714] Lustre: Skipped 1 previous similar message [ 6891.168948] Key type lgssc unregistered [ 6891.559521] LNet: 153144:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6891.581634] LNetError: 153144:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6891.603842] LNet: Removed LNI 192.168.206.33@tcp [ 6892.294284] Key type .llcrypt unregistered [ 6892.296064] Key type ._llcrypt unregistered [ 6908.561407] Key type ._llcrypt registered [ 6908.563649] Key type .llcrypt registered [ 6909.985787] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 08:17:40 (1787833060) [ 6910.882247] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6910.895679] alg: No test for adler32 (adler32-zlib) [ 6912.002485] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 6912.206060] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 6913.831154] Key type lgssc registered [ 6914.815100] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6970.725791] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6976.368481] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6997.260299] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7018.277808] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7019.778780] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7020.922832] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 7024.339380] LustreError: lustre-MDT0001-mdc-ffff9b3198588800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7024.364219] Lustre: lustre-MDT0001-mdc-ffff9b3198588800: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 7029.698588] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7031.251845] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7052.832762] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7057.350527] Lustre: Unmounted lustre-client [ 7089.732976] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 08:20:40 (1787833240) [ 7179.858171] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7185.975438] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7206.811620] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7207.485525] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 7231.862539] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7233.299263] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7236.585616] Lustre: lustre-OST0001-osc-ffff9b31892a3800: Connection to lustre-OST0001 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7245.526177] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7255.842644] Lustre: Unmounted lustre-client [ 7288.658926] Key type lgssc unregistered [ 7288.954920] LNet: 162754:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7288.960438] LNetError: 162754:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7288.984191] LNet: Removed LNI 192.168.206.33@tcp [ 7289.731667] Key type .llcrypt unregistered [ 7289.736878] Key type ._llcrypt unregistered [ 7321.217872] Key type ._llcrypt registered [ 7321.223570] Key type .llcrypt registered [ 7322.943143] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 08:24:33 (1787833473) [ 7325.369328] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7325.381392] alg: No test for adler32 (adler32-zlib) [ 7326.526574] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 7326.714641] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 7328.375225] Key type lgssc registered [ 7329.530575] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7374.284748] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7379.044903] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7397.748619] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7400.536841] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 7445.610745] Lustre: Unmounted lustre-client [ 7484.716546] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7485.498884] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 7521.789106] Lustre: Unmounted lustre-client [ 7559.341174] Key type lgssc unregistered [ 7559.687909] LNet: 167205:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7559.700818] LNetError: 167205:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7559.723813] LNet: Removed LNI 192.168.206.33@tcp [ 7560.347099] Key type .llcrypt unregistered [ 7560.351101] Key type ._llcrypt unregistered [ 7575.403528] Key type ._llcrypt registered [ 7575.413347] Key type .llcrypt registered [ 7576.654970] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 08:28:47 (1787833727) [ 7578.981483] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7579.130899] alg: No test for adler32 (adler32-zlib) [ 7580.277315] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 7580.564111] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 7582.239184] Key type lgssc registered [ 7583.518173] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7633.440767] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7639.566421] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7660.868445] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7662.583227] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 7681.299691] Lustre: Unmounted lustre-client [ 7709.806799] Key type lgssc unregistered [ 7710.078924] LNet: 170967:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7710.083859] LNetError: 170967:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7710.099061] LNet: Removed LNI 192.168.206.33@tcp [ 7710.653780] Key type .llcrypt unregistered [ 7710.660219] Key type ._llcrypt unregistered [ 7723.003876] Key type ._llcrypt registered [ 7723.007476] Key type .llcrypt registered [ 7723.524399] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7723.544849] alg: No test for adler32 (adler32-zlib) [ 7724.803531] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 7725.226055] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 7726.908646] Key type lgssc registered [ 7727.945443] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7774.480489] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7779.778565] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7800.700892] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7802.261663] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 7811.277184] Lustre: Unmounted lustre-client [ 7840.236750] Key type lgssc unregistered [ 7840.486702] LNet: 174035:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7840.494875] LNetError: 174035:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7840.509985] LNet: Removed LNI 192.168.206.33@tcp [ 7841.268954] Key type .llcrypt unregistered [ 7841.273757] Key type ._llcrypt unregistered [ 7858.488866] Key type ._llcrypt registered [ 7858.495225] Key type .llcrypt registered [ 7860.025899] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 08:33:30 (1787834010) [ 7862.443958] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7862.529650] alg: No test for adler32 (adler32-zlib) [ 7863.687262] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 7863.957092] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 7865.671268] Key type lgssc registered [ 7866.891888] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7919.555758] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7925.690435] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7945.929983] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7948.570612] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 7971.458355] Lustre: Unmounted lustre-client [ 7997.442889] Key type lgssc unregistered [ 7997.672402] LNet: 177795:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7997.691268] LNetError: 177795:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7997.724150] LNet: Removed LNI 192.168.206.33@tcp [ 7998.517153] Key type .llcrypt unregistered [ 7998.520389] Key type ._llcrypt unregistered [ 8009.643603] Key type ._llcrypt registered [ 8009.646381] Key type .llcrypt registered [ 8010.176681] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8010.187477] alg: No test for adler32 (adler32-zlib) [ 8011.373849] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 8011.620586] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 8013.327246] Key type lgssc registered [ 8014.611228] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8063.853628] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8069.693649] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8089.310930] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8091.005921] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 8098.613207] Lustre: Unmounted lustre-client [ 8130.402790] Key type lgssc unregistered [ 8130.707932] LNet: 180860:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8130.715762] LNetError: 180860:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8130.743401] LNet: Removed LNI 192.168.206.33@tcp [ 8131.424423] Key type .llcrypt unregistered [ 8131.426131] Key type ._llcrypt unregistered [ 8147.934774] Key type ._llcrypt registered [ 8147.938309] Key type .llcrypt registered [ 8149.231927] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 08:38:20 (1787834300) [ 8172.104581] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8172.141161] alg: No test for adler32 (adler32-zlib) [ 8173.462758] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 8173.903324] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 8175.794101] Key type lgssc registered [ 8177.603416] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8253.486158] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8259.200867] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8281.987801] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8325.776041] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 08:41:16 (1787834476) [ 8355.101086] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8360.902294] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8381.234545] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8382.931080] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 8387.427918] Lustre: Unmounted lustre-client [ 8412.730615] Key type lgssc unregistered [ 8412.990874] LNet: 187963:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8413.002057] LNetError: 187963:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8413.021782] LNet: Removed LNI 192.168.206.33@tcp [ 8413.644623] Key type .llcrypt unregistered [ 8413.648364] Key type ._llcrypt unregistered [ 8427.794572] Key type ._llcrypt registered [ 8427.797822] Key type .llcrypt registered [ 8429.191722] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8431.218323] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 08:43:01 (1787834581) [ 8449.438431] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8449.469637] alg: No test for adler32 (adler32-zlib) [ 8450.528978] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 8450.755731] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 8452.407201] Key type lgssc registered [ 8453.721945] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8545.100355] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8550.762915] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8571.022351] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8592.253075] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8594.928860] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 8618.788296] Lustre: Unmounted lustre-client [ 8740.285712] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8745.501025] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8764.345923] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8798.898221] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 08:49:10 (1787834950) [ 8800.333298] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8801.653294] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 08:49:12 (1787834952) [ 8888.771168] Key type lgssc unregistered [ 8888.995895] LNet: 199412:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8889.007217] LNetError: 199412:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8889.026892] LNet: Removed LNI 192.168.206.33@tcp [ 8889.757804] Key type .llcrypt unregistered [ 8889.760112] Key type ._llcrypt unregistered [ 8904.353617] Key type ._llcrypt registered [ 8904.356472] Key type .llcrypt registered [ 8905.641747] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 08:50:56 (1787835056) [ 8945.739853] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8945.837472] alg: No test for adler32 (adler32-zlib) [ 8946.898096] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 8947.247710] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 8948.951291] Key type lgssc registered [ 8950.163128] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9003.603114] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9012.623811] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9047.786678] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9074.974749] Key type lgssc unregistered [ 9075.236713] LNet: 203147:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9075.249667] LNetError: 203147:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9075.272936] LNet: Removed LNI 192.168.206.33@tcp [ 9076.239280] Key type .llcrypt unregistered [ 9076.241528] Key type ._llcrypt unregistered [ 9089.301132] Key type ._llcrypt registered [ 9089.304639] Key type .llcrypt registered [ 9090.500607] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 08:54:01 (1787835241) [ 9092.973722] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9093.002901] alg: No test for adler32 (adler32-zlib) [ 9094.133902] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 9094.357094] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 9096.032505] Key type lgssc registered [ 9097.291347] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9140.912676] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9146.802424] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9167.716354] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9169.322931] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 9189.868707] Lustre: lustre-MDT0000-mdc-ffff9b31892a3800: Connection to lustre-MDT0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9200.123590] Lustre: lustre-MDT0001-mdc-ffff9b31892a3800: Connection to lustre-MDT0001 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9211.360937] Lustre: 204135:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787835347/real 1787835347] req@000000009bc9cc55 x1874681130992768/t0(0) o400->MGC192.168.206.133@tcp@192.168.206.133@tcp:26/25 lens 224/224 e 0 to 1 dl 1787835363 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9211.408674] LustreError: MGC192.168.206.133@tcp: Connection to MGS (at 192.168.206.133@tcp) was lost; in progress operations using this service will fail [ 9236.072662] Lustre: Evicted from MGS (at 192.168.206.133@tcp) after server handle changed from 0xb64c11fcde878658 to 0xb64c11fcde87a258 [ 9236.087390] Lustre: MGC192.168.206.133@tcp: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 9265.140423] LustreError: lustre-MDT0000-mdc-ffff9b31892a3800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9265.312641] Lustre: lustre-MDT0000-mdc-ffff9b31892a3800: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 9272.737844] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9274.444173] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9280.573065] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9282.725777] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9284.961367] Lustre: Unmounted lustre-client [ 9311.316568] Key type lgssc unregistered [ 9311.549260] LNet: 208100:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9311.563474] LNetError: 208100:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9311.583668] LNet: Removed LNI 192.168.206.33@tcp [ 9312.268136] Key type .llcrypt unregistered [ 9312.272149] Key type ._llcrypt unregistered [ 9325.878452] Key type ._llcrypt registered [ 9325.881729] Key type .llcrypt registered [ 9327.010767] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 08:57:58 (1787835478) [ 9329.159385] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9329.185946] alg: No test for adler32 (adler32-zlib) [ 9330.346864] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 9330.714054] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 9332.463609] Key type lgssc registered [ 9333.676177] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9375.944513] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9381.301710] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9432.974555] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9438.734634] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9474.901851] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9497.673778] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9536.876214] Key type lgssc unregistered [ 9537.105305] LNet: 213407:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9537.118864] LNetError: 213407:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9537.145197] LNet: Removed LNI 192.168.206.33@tcp [ 9537.950764] Key type .llcrypt unregistered [ 9537.955374] Key type ._llcrypt unregistered [ 9585.532572] Key type ._llcrypt registered [ 9585.536694] Key type .llcrypt registered [ 9587.272421] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 09:02:17 (1787835737) [ 9620.556109] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9620.583973] alg: No test for adler32 (adler32-zlib) [ 9621.710758] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [ 9621.978919] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [ 9623.783414] Key type lgssc registered [ 9625.152236] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9713.070799] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9719.320206] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9741.442500] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9781.485216] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 09:05:32 (1787835932) [ 9788.779138] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 09:05:39 (1787835939) [ 9824.910751] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9832.975861] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9859.016117] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9860.719855] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [ 9866.489374] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9868.430648] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9870.441828] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9872.560546] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9875.955369] Lustre: lustre-MDT0000-mdc-ffff9b3185bf7800: Connection to lustre-MDT0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9892.127296] Lustre: 215300:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787836028/real 1787836028] req@00000000b4cc6a5a x1874681684567552/t0(0) o400->MGC192.168.206.133@tcp@192.168.206.133@tcp:26/25 lens 224/224 e 0 to 1 dl 1787836044 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9892.156282] LustreError: MGC192.168.206.133@tcp: Connection to MGS (at 192.168.206.133@tcp) was lost; in progress operations using this service will fail [ 9902.600063] Lustre: Evicted from MGS (at 192.168.206.133@tcp) after server handle changed from 0x55e843125048d9ab to 0x55e843125048dc1a [ 9902.611937] Lustre: MGC192.168.206.133@tcp: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 9907.945274] Lustre: lustre-MDT0000-mdc-ffff9b3185bf7800: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 9917.884237] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9919.772621] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9923.305422] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9928.172768] Lustre: lustre-MDT0000-mdc-ffff9b3185bf7800: Connection to lustre-MDT0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9944.351846] Lustre: 215300:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787836080/real 1787836080] req@000000003ef1ccbc x1874681684576896/t0(0) o400->MGC192.168.206.133@tcp@192.168.206.133@tcp:26/25 lens 224/224 e 0 to 1 dl 1787836096 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9944.368734] LustreError: MGC192.168.206.133@tcp: Connection to MGS (at 192.168.206.133@tcp) was lost; in progress operations using this service will fail [ 9953.772479] Lustre: Evicted from MGS (at 192.168.206.133@tcp) after server handle changed from 0x55e843125048dc1a to 0x55e843125048de2e [ 9953.786516] Lustre: MGC192.168.206.133@tcp: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 9960.634250] Lustre: lustre-MDT0000-mdc-ffff9b3185bf7800: Connection restored to 192.168.206.133@tcp (at 192.168.206.133@tcp) [ 9969.824661] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9971.500660] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9975.582731] Lustre: Unmounted lustre-client [10053.390617] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10060.159638] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10082.488691] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10098.722969] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [10100.709239] Lustre: Unmounted lustre-client [10134.858862] Key type lgssc unregistered [10135.146838] LNet: 225895:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10135.164202] LNetError: 225895:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10135.189397] LNet: Removed LNI 192.168.206.33@tcp [10135.997179] Key type .llcrypt unregistered [10136.000064] Key type ._llcrypt unregistered [10150.836313] Key type ._llcrypt registered [10150.839937] Key type .llcrypt registered [10152.208394] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 09:11:43 (1787836303) [10156.107209] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10156.132530] alg: No test for adler32 (adler32-zlib) [10157.164738] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [10157.428561] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [10159.119177] Key type lgssc registered [10160.252512] Lustre: Echo OBD driver; http://www.lustre.org/ [10207.553855] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10213.601351] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10237.505197] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10240.355476] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [10249.264746] Lustre: Unmounted lustre-client [10322.844743] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10329.351313] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10353.177619] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10353.791450] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [10363.462129] Lustre: Unmounted lustre-client [10430.632261] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10435.568912] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10455.871783] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10456.453485] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [10458.793030] Lustre: Unmounted lustre-client [10485.469713] Key type lgssc unregistered [10485.722496] LNet: 232951:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10485.730925] LNetError: 232951:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10485.746167] LNet: Removed LNI 192.168.206.33@tcp [10486.483227] Key type .llcrypt unregistered [10486.487985] Key type ._llcrypt unregistered [10501.286307] Key type ._llcrypt registered [10501.289035] Key type .llcrypt registered [10502.592800] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 09:17:33 (1787836653) [10505.857621] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10505.882849] alg: No test for adler32 (adler32-zlib) [10507.087484] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [10507.402258] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [10509.105179] Key type lgssc registered [10510.479403] Lustre: Echo OBD driver; http://www.lustre.org/ [10552.026956] Key type lgssc unregistered [10552.313881] LNet: 235277:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10552.323515] LNetError: 235277:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10552.348909] LNet: Removed LNI 192.168.206.33@tcp [10553.249332] Key type .llcrypt unregistered [10553.253563] Key type ._llcrypt unregistered [10580.219341] Key type ._llcrypt registered [10580.221955] Key type .llcrypt registered [10580.683809] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10580.701717] alg: No test for adler32 (adler32-zlib) [10581.754381] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [10582.132959] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [10583.864255] Key type lgssc registered [10584.955568] Lustre: Echo OBD driver; http://www.lustre.org/ [10669.836520] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10677.615889] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10702.209746] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10746.429565] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10748.000465] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 09:21:39 (1787836899) [10785.407139] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10790.748548] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10811.797189] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10835.389060] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10838.229751] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [10843.627658] Lustre: lustre-OST0001-osc-ffff9b3184ed2800: Connection to lustre-OST0001 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [10849.914721] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10860.261904] Lustre: Unmounted lustre-client [10896.862588] Key type lgssc unregistered [10897.149769] LNet: 242403:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10897.168463] LNetError: 242403:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10897.197655] LNet: Removed LNI 192.168.206.33@tcp [10897.949633] Key type .llcrypt unregistered [10897.956571] Key type ._llcrypt unregistered [10933.054477] Key type ._llcrypt registered [10933.057390] Key type .llcrypt registered [10934.814344] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 09:24:45 (1787837085) [10947.892880] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10947.910263] alg: No test for adler32 (adler32-zlib) [10949.008916] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [10949.274596] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [10950.983241] Key type lgssc registered [10952.551702] Lustre: Echo OBD driver; http://www.lustre.org/ [11003.276131] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11009.503417] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11030.915563] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 09:26:21 (1787837181) [11062.938787] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11068.617956] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11089.675248] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11092.660053] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [11105.829234] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11107.633135] Lustre: Unmounted lustre-client [11205.517324] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11211.102382] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11260.024821] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11260.528415] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [11262.947632] Lustre: Unmounted lustre-client [11289.137871] Key type lgssc unregistered [11289.394850] LNet: 250100:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11289.407591] LNetError: 250100:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11289.423295] LNet: Removed LNI 192.168.206.33@tcp [11290.024175] Key type .llcrypt unregistered [11290.028374] Key type ._llcrypt unregistered [11315.649212] Key type ._llcrypt registered [11315.651750] Key type .llcrypt registered [11316.095898] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11316.112273] alg: No test for adler32 (adler32-zlib) [11317.178900] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [11317.425322] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [11319.151392] Key type lgssc registered [11320.742746] Lustre: Echo OBD driver; http://www.lustre.org/ [11399.202869] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11404.174629] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11425.762277] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11465.039909] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11466.720160] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 09:33:37 (1787837617) [11497.565693] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11502.762675] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11521.530297] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11525.604512] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [11528.250222] Lustre: Unmounted lustre-client [11554.603208] Key type lgssc unregistered [11554.828148] LNet: 256737:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11554.837441] LNetError: 256737:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11554.858662] LNet: Removed LNI 192.168.206.33@tcp [11555.677873] Key type .llcrypt unregistered [11555.682577] Key type ._llcrypt unregistered [11571.986040] Key type ._llcrypt registered [11571.992523] Key type .llcrypt registered [11573.373876] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11575.141844] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 09:35:26 (1787837726) [11586.370350] Key type .llcrypt unregistered [11586.373380] Key type ._llcrypt unregistered [11595.474523] Key type ._llcrypt registered [11595.480938] Key type .llcrypt registered [11596.003298] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11596.014821] alg: No test for adler32 (adler32-zlib) [11597.200938] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [11597.554747] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [11599.271191] Key type lgssc registered [11600.698726] Lustre: Echo OBD driver; http://www.lustre.org/ [11650.946723] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11666.836886] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [11669.476936] Lustre: Unmounted lustre-client [11695.387199] Key type lgssc unregistered [11695.744937] LNet: 260202:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11695.757181] LNetError: 260202:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11695.774650] LNet: Removed LNI 192.168.206.33@tcp [11696.350994] Key type .llcrypt unregistered [11696.356899] Key type ._llcrypt unregistered [11711.791195] Key type ._llcrypt registered [11711.796406] Key type .llcrypt registered [11712.958511] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 09:37:44 (1787837864) [11715.127067] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11715.253761] alg: No test for adler32 (adler32-zlib) [11716.314776] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [11716.545491] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [11718.201630] Key type lgssc registered [11719.353650] Lustre: Echo OBD driver; http://www.lustre.org/ [11800.865930] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11833.853460] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11838.965843] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11841.744521] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [11844.169386] Lustre: Unmounted lustre-client [11871.684869] Key type lgssc unregistered [11871.892221] LNet: 263750:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11871.899520] LNetError: 263750:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11871.921117] LNet: Removed LNI 192.168.206.33@tcp [11872.772716] Key type .llcrypt unregistered [11872.777619] Key type ._llcrypt unregistered [11888.480639] Key type ._llcrypt registered [11888.482855] Key type .llcrypt registered [11889.539851] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 09:40:40 (1787838040) [11891.497043] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11891.518933] alg: No test for adler32 (adler32-zlib) [11892.602341] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [11892.831120] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [11894.527215] Key type lgssc registered [11895.715235] Lustre: Echo OBD driver; http://www.lustre.org/ [11943.817828] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11949.563149] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11967.312461] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11970.105390] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [11975.147141] Lustre: lustre-MDT0000-mdc-ffff9b3187f5e000: Connection to lustre-MDT0000 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [11980.458841] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11980.492480] LustreError: 266905:0:(file.c:6184:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [11980.979432] LustreError: MGC192.168.206.133@tcp: Connection to MGS (at 192.168.206.133@tcp) was lost; in progress operations using this service will fail [11981.046439] Lustre: Unmounted lustre-client [11999.298312] Key type lgssc unregistered [11999.588471] LNet: 267320:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11999.594551] LNetError: 267320:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11999.614362] LNet: Removed LNI 192.168.206.33@tcp [12000.253341] Key type .llcrypt unregistered [12000.260421] Key type ._llcrypt unregistered [12015.421554] Key type ._llcrypt registered [12015.423985] Key type .llcrypt registered [12016.774666] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 09:42:47 (1787838167) [12019.046883] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12019.067394] alg: No test for adler32 (adler32-zlib) [12020.194109] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [12020.471811] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [12022.207200] Key type lgssc registered [12023.377686] Lustre: Echo OBD driver; http://www.lustre.org/ [12074.957389] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12080.657063] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12103.087752] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12105.881743] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [12115.685944] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12118.135296] Lustre: Unmounted lustre-client [12138.806802] Key type lgssc unregistered [12139.083987] LNet: 270905:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12139.092913] LNetError: 270905:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12139.115836] LNet: Removed LNI 192.168.206.33@tcp [12139.747208] Key type .llcrypt unregistered [12139.755076] Key type ._llcrypt unregistered [12157.556102] Key type ._llcrypt registered [12157.558962] Key type .llcrypt registered [12159.433410] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 09:45:09 (1787838309) [12180.089014] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12180.116614] alg: No test for adler32 (adler32-zlib) [12181.278854] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [12181.489262] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [12183.183241] Key type lgssc registered [12184.726451] Lustre: Echo OBD driver; http://www.lustre.org/ [12288.148496] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12291.027832] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [12331.498676] Lustre: lustre-MDT0001-mdc-ffff9b3187cba800: Connection to lustre-MDT0001 (at 192.168.206.133@tcp) was lost; in progress operations using this service will wait for recovery to complete [12338.292633] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12348.640849] Lustre: Unmounted lustre-client [12392.240746] Key type lgssc unregistered [12392.613624] LNet: 276692:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12392.629961] LNetError: 276692:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12392.660201] LNet: Removed LNI 192.168.206.33@tcp [12393.387451] Key type .llcrypt unregistered [12393.389767] Key type ._llcrypt unregistered [12410.567395] Key type ._llcrypt registered [12410.570438] Key type .llcrypt registered [12411.885194] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 09:49:22 (1787838562) [12413.390390] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12414.888671] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 09:49:26 (1787838566) [12416.582736] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12418.220048] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 09:49:29 (1787838569) [12419.867136] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12421.273549] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 09:49:32 (1787838572) [12422.958873] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12424.666479] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 09:49:35 (1787838575) [12426.425435] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12427.992508] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 09:49:39 (1787838579) [12436.073377] Key type .llcrypt unregistered [12436.077422] Key type ._llcrypt unregistered [12443.644215] Key type ._llcrypt registered [12443.654419] Key type .llcrypt registered [12444.173112] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12444.198529] alg: No test for adler32 (adler32-zlib) [12445.325132] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [12445.563266] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [12447.247655] Key type lgssc registered [12448.794318] Lustre: Echo OBD driver; http://www.lustre.org/ [12525.305742] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12531.908440] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12558.210792] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12559.981076] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [12563.720547] Lustre: Unmounted lustre-client [12604.211649] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 09:52:35 (1787838755) [12638.655302] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12645.248974] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12680.136163] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12686.413959] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [12688.562619] Lustre: Unmounted lustre-client [12733.345062] LNet: 1 local NIs in recovery (showing 1): 192.168.206.33@tcp [12733.434454] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 09:54:44 (1787838884) [13374.392857] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13378.810537] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13412.428580] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13508.410163] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 10:07:39 (1787839659) [13519.626142] Key type lgssc unregistered [13519.852565] LNet: 290242:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13519.863526] LNetError: 290242:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13519.884935] LNet: Removed LNI 192.168.206.33@tcp [13520.559381] Key type .llcrypt unregistered [13520.562112] Key type ._llcrypt unregistered [13661.974722] Key type ._llcrypt registered [13661.981411] Key type .llcrypt registered [13662.466789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13662.483254] alg: No test for adler32 (adler32-zlib) [13663.560295] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [13663.881336] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [13665.575289] Key type lgssc registered [13667.199209] Lustre: Echo OBD driver; http://www.lustre.org/ [13756.133289] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13762.367131] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13781.404336] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13813.296737] Key type lgssc unregistered [13813.648173] LNet: 293945:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13813.662502] LNetError: 293945:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13813.682812] LNet: Removed LNI 192.168.206.33@tcp [13814.518826] Key type .llcrypt unregistered [13814.523514] Key type ._llcrypt unregistered [13847.483226] Key type ._llcrypt registered [13847.485164] Key type .llcrypt registered [13848.500971] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 10:13:19 (1787839999) [13864.309482] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13864.329764] alg: No test for adler32 (adler32-zlib) [13865.394378] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [13865.610530] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [13867.271490] Key type lgssc registered [13868.405789] Lustre: Echo OBD driver; http://www.lustre.org/ [13916.039905] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 10:14:26 (1787840066) [13927.684745] Key type lgssc unregistered [13927.944609] LNet: 297517:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13927.950354] LNetError: 297517:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13927.967382] LNet: Removed LNI 192.168.206.33@tcp [13928.603880] Key type .llcrypt unregistered [13928.606856] Key type ._llcrypt unregistered [13937.348865] Key type ._llcrypt registered [13937.358158] Key type .llcrypt registered [13937.768930] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13937.786962] alg: No test for adler32 (adler32-zlib) [13938.896302] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [13939.177505] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [13940.855994] Key type lgssc registered [13941.842650] Lustre: Echo OBD driver; http://www.lustre.org/ [13989.325939] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13994.677671] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14016.860652] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14284.082342] LNet: Added LNI 192.168.206.33@tcp50 [8/256/0/180] [14286.109650] LNet: Removed LNI 192.168.206.33@tcp [14287.972095] Lustre: 301924:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff9b3185514000: config has no valid NIDs, force dynamic NIDs [14289.132794] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [14289.324929] Lustre: Unmounted lustre-client [14291.787146] Key type lgssc unregistered [14292.134589] LNet: 302188:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14292.143936] LNetError: 302188:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14293.222662] LNet: Removed LNI 192.168.206.33@tcp50 [14293.839681] Key type .llcrypt unregistered [14293.844729] Key type ._llcrypt unregistered [14310.160119] Key type ._llcrypt registered [14310.162935] Key type .llcrypt registered [14310.636681] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14310.648369] alg: No test for adler32 (adler32-zlib) [14311.692967] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [14311.949255] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [14313.671178] Key type lgssc registered [14314.816613] Lustre: Echo OBD driver; http://www.lustre.org/ [14378.653650] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14383.454257] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14391.437286] LNet: Added LNI 192.168.206.33@tcp50 [8/256/0/180] [14392.302273] LNet: Removed LNI 192.168.206.33@tcp [14393.473604] Lustre: 304878:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff9b31a8030000: config has no valid NIDs, force dynamic NIDs [14394.743463] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [14395.539977] Lustre: Unmounted lustre-client [14430.044392] Key type lgssc unregistered [14430.365611] LNet: 305753:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14430.376986] LNetError: 305753:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14430.402111] LNet: Removed LNI 192.168.206.33@tcp50 [14431.003157] Key type .llcrypt unregistered [14431.007223] Key type ._llcrypt unregistered [14441.024042] Key type ._llcrypt registered [14441.026895] Key type .llcrypt registered [14442.407707] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 10:23:13 (1787840593) [14458.382935] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14458.419445] alg: No test for adler32 (adler32-zlib) [14459.492284] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [14459.706092] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [14461.411815] Key type lgssc registered [14462.662579] Lustre: Echo OBD driver; http://www.lustre.org/ [14531.859809] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14536.371497] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14555.209256] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14590.327337] Key type lgssc unregistered [14590.974073] LNet: 310503:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14590.987991] LNetError: 310503:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14591.024032] LNet: Removed LNI 192.168.206.33@tcp [14591.791918] Key type .llcrypt unregistered [14591.797209] Key type ._llcrypt unregistered [14605.048589] Key type ._llcrypt registered [14605.049910] Key type .llcrypt registered [14606.652940] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 10:25:57 (1787840757) [14609.156431] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14609.189428] alg: No test for adler32 (adler32-zlib) [14610.264878] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [14610.524722] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [14612.271463] Key type lgssc registered [14613.420864] Lustre: Echo OBD driver; http://www.lustre.org/ [14658.556047] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14664.932507] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14681.166202] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14683.636126] Lustre: Mounted lustre-client - version 2.17.57_68_geb35bb6 [14734.590672] Lustre: Mounted fs15246-client - version 2.17.57_68_geb35bb6 [14746.862875] Lustre: Unmounted fs15246-client [14771.965829] Lustre: Unmounted lustre-client [14797.593454] Key type lgssc unregistered [14797.847780] LNet: 315369:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14797.870511] LNetError: 315369:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14797.887961] LNet: Removed LNI 192.168.206.33@tcp [14798.415917] Key type .llcrypt unregistered [14798.420520] Key type ._llcrypt unregistered [14807.197263] Key type ._llcrypt registered [14807.200045] Key type .llcrypt registered [14808.348732] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 10:29:19 (1787840959) [14810.319996] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14810.341344] alg: No test for adler32 (adler32-zlib) [14811.346987] Lustre: Lustre: Build Version: 2.17.57_68_geb35bb6 [14811.539956] LNet: Added LNI 192.168.206.33@tcp [8/256/0/180] [14813.207208] Key type lgssc registered [14814.383473] Lustre: Echo OBD driver; http://www.lustre.org/ [14938.601193] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14945.913821] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14973.044855] Lustre: DEBUG MARKER: oleg633-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15068.789505] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 14801 sec ========= 10:33:39 (1787841219) [15070.295860] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 10:33:41 (1787841221) === [15073.942794] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 10:33:44 (1787841224) === [15114.884266] Key type lgssc unregistered [15115.216688] LNet: 324639:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15115.224283] LNetError: 324639:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15115.270814] LNet: Removed LNI 192.168.206.33@tcp [15116.214718] Key type .llcrypt unregistered [15116.216388] Key type ._llcrypt unregistered