[ 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 427926550 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003253] x2apic enabled [ 0.004006] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.007730] ..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.008035] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009017] pid_max: default: 32768 minimum: 301 [ 0.010137] LSM: Security Framework initializing [ 0.011033] Yama: becoming mindful. [ 0.012031] SELinux: Initializing. [ 0.013058] *** VALIDATE selinux *** [ 0.022591] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026591] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027133] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028066] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029074] *** VALIDATE tmpfs *** [ 0.031088] *** VALIDATE proc *** [ 0.032203] *** VALIDATE cgroup *** [ 0.033008] *** VALIDATE cgroup2 *** [ 0.034214] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036101] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037003] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038023] Spectre V2 : User space: Vulnerable [ 0.039003] Speculative Store Bypass: Vulnerable [ 0.042282] debug: unmapping init [mem 0xffffffff94c59000-0xffffffff94c60fff] [ 0.044000] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044860] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045014] ... version: 2 [ 0.046007] ... bit width: 48 [ 0.046970] ... generic registers: 4 [ 0.047020] ... value mask: 0000ffffffffffff [ 0.048009] ... max period: 00007fffffffffff [ 0.049006] ... fixed-purpose events: 3 [ 0.050007] ... event mask: 000000070000000f [ 0.052202] rcu: Hierarchical SRCU implementation. [ 0.055379] smp: Bringing up secondary CPUs ... [ 0.056768] x86: Booting SMP configuration: [ 0.057036] .... node #0, CPUs: #1 #2 #3 [ 0.063732] smp: Brought up 1 node, 4 CPUs [ 0.064901] smpboot: Max logical packages: 1 [ 0.065006] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.135623] node 0 deferred pages initialised in 66ms [ 0.141024] devtmpfs: initialized [ 0.142278] x86/mm: Memory block size: 128MB [ 0.145205] gcov: version magic: 0x41383552 [ 0.148287] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.151090] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.154378] pinctrl core: initialized pinctrl subsystem [ 0.156094] [ 0.156490] ************************************************************* [ 0.158008] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.159008] ** ** [ 0.160010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.163012] ** ** [ 0.165010] ** This means that this kernel is built to expose internal ** [ 0.167026] ** IOMMU data structures, which may compromise security on ** [ 0.169009] ** your system. ** [ 0.171008] ** ** [ 0.173008] ** If you see this message and you are not debugging the ** [ 0.174011] ** kernel, report this immediately to your vendor! ** [ 0.177009] ** ** [ 0.179021] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.182036] ************************************************************* [ 0.185983] NET: Registered protocol family 16 [ 0.188296] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.194089] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.197079] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.209064] cpuidle: using governor menu [ 0.210567] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.212000] PCI: Using configuration type 1 for base access [ 0.214157] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.226501] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.229011] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.235491] cryptd: max_cpu_qlen set to 1000 [ 0.240441] ACPI: Added _OSI(Module Device) [ 0.242014] ACPI: Added _OSI(Processor Device) [ 0.243010] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.246014] ACPI: Added _OSI(Processor Aggregator Device) [ 0.254417] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.262718] ACPI: Interpreter enabled [ 0.265082] ACPI: PM: (supports S0 S3 S4 S5) [ 0.267013] ACPI: Using IOAPIC for interrupt routing [ 0.269126] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.272425] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.283000] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.286050] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.290024] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.293092] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.296655] acpiphp: Slot [2] registered [ 0.298099] acpiphp: Slot [5] registered [ 0.300092] acpiphp: Slot [6] registered [ 0.302207] acpiphp: Slot [3] registered [ 0.303105] acpiphp: Slot [4] registered [ 0.304000] acpiphp: Slot [7] registered [ 0.304000] acpiphp: Slot [8] registered [ 0.305129] acpiphp: Slot [9] registered [ 0.306000] acpiphp: Slot [10] registered [ 0.307124] acpiphp: Slot [11] registered [ 0.308107] acpiphp: Slot [12] registered [ 0.309095] acpiphp: Slot [13] registered [ 0.309999] acpiphp: Slot [14] registered [ 0.311046] acpiphp: Slot [15] registered [ 0.311756] acpiphp: Slot [16] registered [ 0.313080] acpiphp: Slot [17] registered [ 0.314063] acpiphp: Slot [18] registered [ 0.315034] acpiphp: Slot [19] registered [ 0.316078] acpiphp: Slot [20] registered [ 0.317026] acpiphp: Slot [21] registered [ 0.317749] acpiphp: Slot [22] registered [ 0.318069] acpiphp: Slot [23] registered [ 0.319086] acpiphp: Slot [24] registered [ 0.321118] acpiphp: Slot [25] registered [ 0.322078] acpiphp: Slot [26] registered [ 0.324069] acpiphp: Slot [27] registered [ 0.325000] acpiphp: Slot [28] registered [ 0.325000] acpiphp: Slot [29] registered [ 0.325000] acpiphp: Slot [30] registered [ 0.328080] acpiphp: Slot [31] registered [ 0.330659] PCI host bridge to bus 0000:00 [ 0.334025] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.336010] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.337044] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.339012] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.341017] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.343016] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.345268] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.348096] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.354197] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.364011] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.367060] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.371018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.373024] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.375011] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.377566] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.380897] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.384036] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.386956] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.392031] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.399012] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.403770] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.407074] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.412011] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.416017] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.429000] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.439000] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.459017] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.471013] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.501018] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.512000] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.512000] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.512000] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.512000] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.512293] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.531129] iommu: Default domain type: Passthrough [ 0.533583] SCSI subsystem initialized [ 0.534086] ACPI: bus type USB registered [ 0.535075] usbcore: registered new interface driver usbfs [ 0.537162] usbcore: registered new interface driver hub [ 0.539096] usbcore: registered new device driver usb [ 0.540223] pps_core: LinuxPPS API ver. 1 registered [ 0.542012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.546112] PTP clock support registered [ 0.550090] EDAC MC: Ver: 3.0.0 [ 0.551155] PCI: Using ACPI for IRQ routing [ 0.552000] NetLabel: Initializing [ 0.552005] NetLabel: domain hash size = 128 [ 0.552998] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.554100] NetLabel: unlabeled traffic allowed by default [ 0.557003] vgaarb: loaded [ 0.558304] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.560009] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.566689] clocksource: Switched to clocksource kvm-clock [ 0.670241] VFS: Disk quotas dquot_6.6.0 [ 0.671212] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.672943] *** VALIDATE ramfs *** [ 0.673874] *** VALIDATE hugetlbfs *** [ 0.675736] pnp: PnP ACPI init [ 0.677699] pnp: PnP ACPI: found 6 devices [ 0.691169] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.694436] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.696730] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.698807] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.700107] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.701904] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.704064] NET: Registered protocol family 2 [ 0.706151] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.709465] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.712894] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.717177] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.719904] TCP: Hash tables configured (established 65536 bind 65536) [ 0.721948] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.724243] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.726219] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.728574] NET: Registered protocol family 1 [ 0.730634] RPC: Registered named UNIX socket transport module. [ 0.732069] RPC: Registered udp transport module. [ 0.733331] RPC: Registered tcp transport module. [ 0.734769] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.736739] NET: Registered protocol family 44 [ 0.738414] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.739725] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.741212] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.742991] PCI: CLS 0 bytes, default 64 [ 0.743922] Unpacking initramfs... [ 2.238736] debug: unmapping init [mem 0xffff946ebcc64000-0xffff946ebffcffff] [ 2.244073] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.247215] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.251180] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.747615] Initialise system trusted keyrings [ 2.749102] Key type blacklist registered [ 2.750816] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.759233] zbud: loaded [ 2.762042] *** VALIDATE nfs *** [ 2.763258] *** VALIDATE nfs4 *** [ 2.764697] pstore: using deflate compression [ 2.770154] Platform Keyring initialized [ 2.857481] NET: Registered protocol family 38 [ 2.859008] Key type asymmetric registered [ 2.860613] Asymmetric key parser 'x509' registered [ 2.862662] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.865816] io scheduler mq-deadline registered [ 2.867729] io scheduler kyber registered [ 2.869586] io scheduler bfq registered [ 2.870854] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.874410] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.877125] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.879872] ACPI: Power Button [PWRF] [ 2.884465] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.889484] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.897981] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.927858] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.979159] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.984375] Non-volatile memory driver v1.3 [ 2.987403] Linux agpgart interface v0.103 [ 3.025106] virtio_blk virtio1: [vda] 145800 512-byte logical blocks (74.6 MB/71.2 MiB) [ 3.027882] vda: detected capacity change from 0 to 74649600 [ 3.040652] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.042407] vdb: detected capacity change from 0 to 1073741824 [ 3.046638] libphy: Fixed MDIO Bus: probed [ 3.052656] usbcore: registered new interface driver usbserial_generic [ 3.054382] usbserial: USB Serial support registered for generic [ 3.056454] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.060311] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.061675] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.063641] mousedev: PS/2 mouse device common for all mice [ 3.067288] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.069330] rtc_cmos 00:05: RTC can wake from S4 [ 3.077327] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.077406] rtc_cmos 00:05: registered as rtc0 [ 3.083166] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.084991] intel_pstate: CPU model not supported [ 3.087498] hid: raw HID events driver (C) Jiri Kosina [ 3.087813] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.088822] usbcore: registered new interface driver usbhid [ 3.092436] usbhid: USB HID core driver [ 3.093424] drop_monitor: Initializing network drop monitor service [ 3.094943] Initializing XFRM netlink socket [ 3.096636] NET: Registered protocol family 10 [ 3.099905] Segment Routing with IPv6 [ 3.100727] NET: Registered protocol family 17 [ 3.102031] mpls_gso: MPLS GSO support [ 3.106455] RAS: Correctable Errors collector initialized. [ 3.109084] AVX version of gcm_enc/dec engaged. [ 3.110546] AES CTR mode by8 optimization enabled [ 3.211415] sched_clock: Marking stable (3211316317, 0)->(4169166946, -957850629) [ 3.214673] registered taskstats version 1 [ 3.216526] Loading compiled-in X.509 certificates [ 3.218246] zswap: loaded using pool lzo/zbud [ 3.243797] Key type big_key registered [ 3.254392] Key type encrypted registered [ 3.255620] ima: No TPM chip found, activating TPM-bypass! [ 3.257219] ima: Allocated hash algorithm: sha1 [ 3.258609] ima: No architecture policies found [ 3.259922] evm: Initialising EVM extended attributes: [ 3.261408] evm: security.selinux [ 3.262439] evm: security.ima [ 3.263563] evm: security.capability [ 3.264639] evm: HMAC attrs: 0x1 [ 3.266623] rtc_cmos 00:05: setting system clock to 2026-07-17 11:37:43 UTC (1784288263) [ 3.273429] debug: unmapping init [mem 0xffffffff95c03000-0xffffffff95dfffff] [ 3.276202] debug: unmapping init [mem 0xffffffff94982000-0xffffffff94c58fff] [ 3.282860] Write protecting the kernel read-only data: 28672k [ 3.288095] debug: unmapping init [mem 0xffffffff93003000-0xffffffff931fffff] [ 3.290924] debug: unmapping init [mem 0xffffffff93914000-0xffffffff939fffff] [ 3.322917] 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.335606] systemd[1]: Detected virtualization kvm. [ 3.340806] systemd[1]: Detected architecture x86-64. [ 3.348534] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.402465] systemd[1]: No hostname configured. [ 3.404189] systemd[1]: Set hostname to . [ 3.405791] random: systemd: uninitialized urandom read (16 bytes read) [ 3.407154] systemd[1]: Initializing machine ID from random generator. [ 3.467138] random: ln: uninitialized urandom read (6 bytes read) [ 3.625594] random: systemd: uninitialized urandom read (16 bytes read) [ 3.629140] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.645487] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.651963] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... Starting Setup Virtual Console... [ OK ] Reached target Paths. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Timers. Starting Apply Kernel Variables... [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Sockets. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.486497] device-mapper: uevent: version 1.0.3 [ 4.488561] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 5.446287] virtio_net virtio0 ens2: renamed from eth0 [ 5.610230] scsi host0: ata_piix [ 5.645179] scsi host1: ata_piix [ 5.646755] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.649084] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.841874] random: crng init done [ 9.844152] random: 7 urandom warning(s) missed due to ratelimiting [ 10.591841] dracut-initqueue[600]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 11.287874] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 12.982729] printk: systemd: 25 output lines suppressed due to ratelimiting [ 13.297033] SELinux: Disabled at runtime. [ 13.428838] 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) [ 13.440440] systemd[1]: Detected virtualization kvm. [ 13.442788] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 14.315539] systemd[1]: initrd-switch-root.service: Succeeded. [ 14.322176] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 14.329463] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 14.335688] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 14.339040] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 14.348916] systemd[1]: Starting Journal Service... Starting Journal Service... [ 14.356303] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. Starting Remount Root and Kernel File Systems... [ OK ] Reached target rpc_pipefs.target. Mounting Huge Pages File System... Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on Process Core Dump Socket. [ 14.430757] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Created slice system-getty.slice. [ OK ] Stopped target Switch Root. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Mounting POSIX Message Queue File System... [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. Starting Apply Kernel Variables... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Mounting Kernel Debug File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 15.430284] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 15.968334] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 16.201502] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 16.764974] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 16.841192] EDAC sbridge: Ver: 1.1.2 [ 18.845163] Key type dns_resolver registered [ 19.267465] NFS: Registering the id_resolver key type [ 19.269732] Key type id_resolver registered [ 19.271529] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Mark the need to relabel after reboot... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target sshd-keygen.target. Starting Login Service... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Hostname Service... [ OK ] Started Login 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 Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ 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 Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg415-client login: [ 49.439174] libcfs: loading out-of-tree module taints kernel. [ 49.457667] Key type ._llcrypt registered [ 49.461805] Key type .llcrypt registered [ 49.715630] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 49.721608] alg: No test for adler32 (adler32-zlib) [ 50.678375] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 50.993820] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 52.607135] Key type lgssc registered [ 53.080351] Lustre: Echo OBD driver; http://www.lustre.org/ [ 109.569459] Lustre: Mounted lustre-client [ 111.871500] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 117.109200] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing check_logdir /tmp/testlogs/ [ 118.630112] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing yml_node [ 120.176346] Lustre: DEBUG MARKER: Client: 2.17.54.173 [ 121.059994] Lustre: DEBUG MARKER: MDS: 2.17.54.173 [ 121.936821] Lustre: DEBUG MARKER: OSS: 2.17.54.173 [ 122.521594] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Jul 17 07:39:42 EDT 2026 [ 128.105766] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 128.614266] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 129.095917] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 139.381771] Lustre: Unmounted lustre-client [ 212.656651] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 214.557544] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 223.053830] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 252.073576] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 07:41:51 (1784288511) [ 252.959105] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 253.589269] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 07:41:53 (1784288513) [ 265.256557] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 267.267950] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 274.795993] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 285.171807] Lustre: Mounted lustre-client [ 286.995801] Lustre: Unmounted lustre-client [ 313.381267] Key type lgssc unregistered [ 313.502402] LNet: 14993:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 313.505728] LNetError: 14993:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 313.517440] LNet: Removed LNI 192.168.204.15@tcp [ 313.801188] Key type .llcrypt unregistered [ 313.802504] Key type ._llcrypt unregistered [ 319.145743] Key type ._llcrypt registered [ 319.147132] Key type .llcrypt registered [ 319.639597] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 07:42:59 (1784288579) [ 320.205796] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 320.213834] alg: No test for adler32 (adler32-zlib) [ 321.085222] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 321.181636] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 322.767249] Key type lgssc registered [ 323.183328] Lustre: Echo OBD driver; http://www.lustre.org/ [ 356.831431] Lustre: Mounted lustre-client [ 432.823448] Lustre: Unmounted lustre-client [ 447.102819] Key type lgssc unregistered [ 447.230506] LNet: 18761:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 447.233139] LNetError: 18761:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 447.240637] LNet: Removed LNI 192.168.204.15@tcp [ 447.506899] Key type .llcrypt unregistered [ 447.509047] Key type ._llcrypt unregistered [ 451.073504] Key type ._llcrypt registered [ 451.074988] Key type .llcrypt registered [ 451.593277] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 07:45:11 (1784288711) [ 452.397614] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 452.421764] alg: No test for adler32 (adler32-zlib) [ 453.294820] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 453.395726] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 454.991199] Key type lgssc registered [ 455.427280] Lustre: Echo OBD driver; http://www.lustre.org/ [ 474.614106] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 476.774222] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 484.605505] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 495.092741] Lustre: Mounted lustre-client [ 499.253406] Lustre: Unmounted lustre-client [ 518.798324] Key type lgssc unregistered [ 518.913359] LNet: 22346:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 518.916660] LNetError: 22346:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 518.927424] LNet: Removed LNI 192.168.204.15@tcp [ 519.177556] Key type .llcrypt unregistered [ 519.179386] Key type ._llcrypt unregistered [ 522.630443] Key type ._llcrypt registered [ 522.632033] Key type .llcrypt registered [ 523.132472] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 07:46:22 (1784288782) [ 524.009467] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 524.021928] alg: No test for adler32 (adler32-zlib) [ 524.884607] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 524.977545] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 526.559250] Key type lgssc registered [ 526.983526] Lustre: Echo OBD driver; http://www.lustre.org/ [ 545.738830] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 547.598343] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 554.471743] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 565.232903] Lustre: Mounted lustre-client [ 568.173949] Lustre: Unmounted lustre-client [ 594.346744] Key type lgssc unregistered [ 594.464609] LNet: 25527:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 594.467223] LNetError: 25527:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 594.478875] LNet: Removed LNI 192.168.204.15@tcp [ 594.739667] Key type .llcrypt unregistered [ 594.740968] Key type ._llcrypt unregistered [ 599.914019] Key type ._llcrypt registered [ 599.915604] Key type .llcrypt registered [ 600.408527] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 07:47:40 (1784288860) [ 601.242759] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 601.251863] alg: No test for adler32 (adler32-zlib) [ 602.114919] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 602.214924] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 603.807331] Key type lgssc registered [ 604.201635] Lustre: Echo OBD driver; http://www.lustre.org/ [ 622.687806] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 624.456889] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 630.682133] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 646.126379] Lustre: Mounted lustre-client [ 651.233747] Lustre: lustre-MDT0000-mdc-ffff946f04e32000: Connection to lustre-MDT0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 656.353849] Lustre: lustre-MDT0001-mdc-ffff946f04e32000: Connection to lustre-MDT0001 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 662.423217] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 672.607109] Lustre: 26484:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784288916/real 1784288916] req@00000000af636886 x1870962477766912/t0(0) o400->MGC192.168.204.115@tcp@192.168.204.115@tcp:26/25 lens 224/224 e 0 to 1 dl 1784288932 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 672.618243] LustreError: MGC192.168.204.115@tcp: Connection to MGS (at 192.168.204.115@tcp) was lost; in progress operations using this service will fail [ 672.705144] Lustre: Unmounted lustre-client [ 683.512749] Key type lgssc unregistered [ 683.636419] LNet: 29163:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 683.640467] LNetError: 29163:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 683.652489] LNet: Removed LNI 192.168.204.15@tcp [ 683.892276] Key type .llcrypt unregistered [ 683.893893] Key type ._llcrypt unregistered [ 688.788586] Key type ._llcrypt registered [ 688.789781] Key type .llcrypt registered [ 689.225293] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 07:49:08 (1784288948) [ 689.881780] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 689.913928] alg: No test for adler32 (adler32-zlib) [ 690.758379] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 690.845886] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 692.423149] Key type lgssc registered [ 692.766508] Lustre: Echo OBD driver; http://www.lustre.org/ [ 709.819532] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 711.574427] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 717.770518] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 733.165852] Lustre: Mounted lustre-client [ 738.274223] Lustre: lustre-OST0000-osc-ffff946f11b9e000: Connection to lustre-OST0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 741.941528] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 752.249510] Lustre: Unmounted lustre-client [ 768.859755] Key type lgssc unregistered [ 768.971311] LNet: 32763:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 768.973240] LNetError: 32763:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 768.985253] LNet: Removed LNI 192.168.204.15@tcp [ 769.204366] Key type .llcrypt unregistered [ 769.205645] Key type ._llcrypt unregistered [ 773.827353] Key type ._llcrypt registered [ 773.828875] Key type .llcrypt registered [ 774.254459] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 07:50:34 (1784289034) [ 774.917808] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 774.950306] alg: No test for adler32 (adler32-zlib) [ 775.806370] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 775.892970] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 777.479150] Key type lgssc registered [ 777.803683] Lustre: Echo OBD driver; http://www.lustre.org/ [ 795.237444] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 797.184972] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 803.851282] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 814.575265] Lustre: Mounted lustre-client [ 816.335848] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 817.563732] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 828.077975] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-07-17 7h51m27s [ 828.778209] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 829.921246] Lustre: lustre-MDT0000-mdc-ffff946f0510d800: Connection to lustre-MDT0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 844.538790] LustreError: 36543:0:(lmv_obd.c:1468:lmv_statfs()) lustre-MDT0000-mdc-ffff946f0510d800: can't stat MDS #0: rc = -19 [ 844.999405] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 847.329089] LustreError: MGC192.168.204.115@tcp: Connection to MGS (at 192.168.204.115@tcp) was lost; in progress operations using this service will fail [ 847.334468] Lustre: Evicted from MGS (at 192.168.204.115@tcp) after server handle changed from 0x8f0b5748531f460e to 0x8f0b5748531f49b1 [ 847.337931] Lustre: MGC192.168.204.115@tcp: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 848.353809] LustreError: lustre-MDT0000-mdc-ffff946f0510d800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 848.359177] Lustre: lustre-MDT0000-mdc-ffff946f0510d800: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 849.338819] Lustre: DEBUG MARKER: Wait for df (36543) ... [ 849.785462] Lustre: DEBUG MARKER: done [ 850.099713] Lustre: Unmounted lustre-client [ 874.298843] Key type lgssc unregistered [ 874.408431] LNet: 37554:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 874.412048] LNetError: 37554:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 874.419259] LNet: Removed LNI 192.168.204.15@tcp [ 874.629990] Key type .llcrypt unregistered [ 874.632055] Key type ._llcrypt unregistered [ 884.266856] Key type ._llcrypt registered [ 884.267812] Key type .llcrypt registered [ 884.674315] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 07:52:24 (1784289144) [ 885.353939] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 885.360018] alg: No test for adler32 (adler32-zlib) [ 886.205913] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 886.288070] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 887.863151] Key type lgssc registered [ 888.217595] Lustre: Echo OBD driver; http://www.lustre.org/ [ 905.464504] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 907.284351] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 913.661969] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 914.816598] Lustre: Mounted lustre-client [ 916.957140] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-07-17 7h52m56s [ 917.495085] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 919.749814] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 920.537521] Lustre: DEBUG MARKER: Creating a test file and stat it [ 941.023163] Lustre: 41704:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784289180/real 1784289180] req@00000000ad480d92 x1870962775560960/t0(0) o101->lustre-MDT0000-mdc-ffff946f0a0c8800@192.168.204.115@tcp:12/10 lens 576/1152 e 0 to 1 dl 1784289200 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 941.033306] Lustre: lustre-MDT0000-mdc-ffff946f0a0c8800: Connection to lustre-MDT0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 941.044610] Lustre: lustre-MDT0000-mdc-ffff946f0a0c8800: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 961.070624] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 961.942576] Lustre: DEBUG MARKER: done [ 962.694752] Lustre: Unmounted lustre-client [ 979.908662] Key type lgssc unregistered [ 980.026521] LNet: 42585:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 980.029969] LNetError: 42585:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 980.037699] LNet: Removed LNI 192.168.204.15@tcp [ 980.279357] Key type .llcrypt unregistered [ 980.281226] Key type ._llcrypt unregistered [ 990.214627] Key type ._llcrypt registered [ 990.216307] Key type .llcrypt registered [ 990.660881] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 07:54:10 (1784289250) [ 991.144463] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 991.672656] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 07:54:11 (1784289251) [ 992.883742] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 992.912682] alg: No test for adler32 (adler32-zlib) [ 993.766703] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 993.849210] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 995.431159] Key type lgssc registered [ 995.764127] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1005.683861] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 07:54:25 (1784289265) [ 1016.150829] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1017.913565] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1024.684853] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1031.130442] Lustre: Mounted lustre-client [ 1032.976632] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1033.610536] Lustre: Unmounted lustre-client [ 1043.161785] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1059.516944] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1061.300556] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1061.468346] Lustre: Mounted lustre-client [ 1062.325833] Lustre: Unmounted lustre-client [ 1088.703157] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1090.535345] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1090.697758] Lustre: Mounted lustre-client [ 1091.620133] Lustre: Unmounted lustre-client [ 1103.179183] Lustre: DEBUG MARKER: files compared the same [ 1117.738464] Key type lgssc unregistered [ 1117.876699] LNet: 50176:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1117.881273] LNetError: 50176:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1117.892875] LNet: Removed LNI 192.168.204.15@tcp [ 1118.184451] Key type .llcrypt unregistered [ 1118.185902] Key type ._llcrypt unregistered [ 1123.443412] Key type ._llcrypt registered [ 1123.445194] Key type .llcrypt registered [ 1123.922918] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 07:56:23 (1784289383) [ 1124.666338] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1124.677185] alg: No test for adler32 (adler32-zlib) [ 1125.551849] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1125.647424] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1127.231107] Key type lgssc registered [ 1127.633362] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1145.764116] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1147.587577] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1154.182237] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1164.779329] Lustre: Mounted lustre-client [ 1166.437325] Lustre: Unmounted lustre-client [ 1184.047987] Key type lgssc unregistered [ 1184.173390] LNet: 53746:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1184.177110] LNetError: 53746:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1184.188477] LNet: Removed LNI 192.168.204.15@tcp [ 1184.450842] Key type .llcrypt unregistered [ 1184.453138] Key type ._llcrypt unregistered [ 1189.756750] Key type ._llcrypt registered [ 1189.758466] Key type .llcrypt registered [ 1190.223707] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 07:57:29 (1784289449) [ 1191.039702] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1191.051461] alg: No test for adler32 (adler32-zlib) [ 1191.909063] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1192.007384] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1193.599187] Key type lgssc registered [ 1193.983341] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1254.073457] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1264.312163] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1266.086839] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1283.049318] Key type lgssc unregistered [ 1283.173340] LNet: 57220:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1283.176443] LNetError: 57220:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1283.190249] LNet: Removed LNI 192.168.204.15@tcp [ 1283.435571] Key type .llcrypt unregistered [ 1283.436569] Key type ._llcrypt unregistered [ 1288.164471] Key type ._llcrypt registered [ 1288.165547] Key type .llcrypt registered [ 1288.604310] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 07:59:08 (1784289548) [ 1289.716950] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1289.721906] alg: No test for adler32 (adler32-zlib) [ 1290.575213] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1290.657387] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1292.239160] Key type lgssc registered [ 1292.589369] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1318.786458] Lustre: Mounted lustre-client [ 1324.181390] Lustre: Unmounted lustre-client [ 1344.222951] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 08:00:04 (1784289604) [ 1382.757306] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1393.649294] Lustre: Mounted lustre-client [ 1399.010430] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1399.015178] LustreError: 63665:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff946f080b6800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 1399.025401] Lustre: 58205:0:(llite_lib.c:4327:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.115@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 1409.337178] Lustre: Unmounted lustre-client [ 1435.321906] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 08:01:35 (1784289695) [ 1438.727522] Key type lgssc unregistered [ 1438.843604] LNet: 64887:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1438.846375] LNetError: 64887:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1438.853617] LNet: Removed LNI 192.168.204.15@tcp [ 1439.070108] Key type .llcrypt unregistered [ 1439.071734] Key type ._llcrypt unregistered [ 1442.832867] Key type ._llcrypt registered [ 1442.833899] Key type .llcrypt registered [ 1443.053507] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1443.060221] alg: No test for adler32 (adler32-zlib) [ 1443.901937] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1443.984349] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1445.559112] Key type lgssc registered [ 1445.933255] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1463.317508] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1465.070724] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1471.618243] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1482.223977] Lustre: Mounted lustre-client [ 1483.860820] Lustre: Unmounted lustre-client [ 1493.029539] Key type lgssc unregistered [ 1493.133639] LNet: 67887:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1493.136093] LNetError: 67887:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1493.146676] LNet: Removed LNI 192.168.204.15@tcp [ 1493.374410] Key type .llcrypt unregistered [ 1493.375466] Key type ._llcrypt unregistered [ 1496.919154] Key type ._llcrypt registered [ 1496.920339] Key type .llcrypt registered [ 1497.090729] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1497.096234] alg: No test for adler32 (adler32-zlib) [ 1497.954590] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1498.048236] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1499.639160] Key type lgssc registered [ 1500.025300] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1555.359613] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1557.262266] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1564.246370] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1574.901002] Lustre: Mounted lustre-client [ 1575.383339] Lustre: Unmounted lustre-client [ 1588.886399] Key type lgssc unregistered [ 1589.015862] LNet: 71301:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1589.020687] LNetError: 71301:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1589.031664] LNet: Removed LNI 192.168.204.15@tcp [ 1589.327917] Key type .llcrypt unregistered [ 1589.329594] Key type ._llcrypt unregistered [ 1594.899974] Key type ._llcrypt registered [ 1594.901202] Key type .llcrypt registered [ 1595.399270] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 08:04:15 (1784289855) [ 1596.107121] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1596.148783] alg: No test for adler32 (adler32-zlib) [ 1596.993918] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1597.073022] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1598.647144] Key type lgssc registered [ 1599.021319] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1616.788631] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1618.403913] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1624.427169] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1634.811446] Lustre: Mounted lustre-client [ 1637.124211] Lustre: Unmounted lustre-client [ 1637.253028] Lustre: Mounted lustre-client [ 1637.978233] Lustre: Unmounted lustre-client [ 1682.706678] Key type lgssc unregistered [ 1682.836417] LNet: 74973:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1682.839982] LNetError: 74973:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1682.852537] LNet: Removed LNI 192.168.204.15@tcp [ 1683.117307] Key type .llcrypt unregistered [ 1683.118913] Key type ._llcrypt unregistered [ 1687.331356] Key type ._llcrypt registered [ 1687.336461] Key type .llcrypt registered [ 1687.530222] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1687.536512] alg: No test for adler32 (adler32-zlib) [ 1688.409241] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1688.508396] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1690.095190] Key type lgssc registered [ 1690.468646] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1708.161784] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1710.034520] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1716.720119] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1727.472794] Lustre: Mounted lustre-client [ 1729.178260] Lustre: Unmounted lustre-client [ 1746.185217] Key type lgssc unregistered [ 1746.298522] LNet: 77996:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1746.300726] LNetError: 77996:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1746.308632] LNet: Removed LNI 192.168.204.15@tcp [ 1746.544311] Key type .llcrypt unregistered [ 1746.546169] Key type ._llcrypt unregistered [ 1751.529294] Key type ._llcrypt registered [ 1751.530418] Key type .llcrypt registered [ 1751.954437] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 08:06:51 (1784290011) [ 1752.658614] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1752.668524] alg: No test for adler32 (adler32-zlib) [ 1753.510648] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1753.592049] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1755.167241] Key type lgssc registered [ 1755.510452] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1773.391764] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1775.129113] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1781.590592] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1791.984325] Lustre: Mounted lustre-client [ 1797.038777] Lustre: lustre: nosquash_nids is cleared [ 1797.045323] Lustre: lustre: root_squash is set to 500:500 [ 1805.933627] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.15@tcp 192.168.0.[2,10]@tcp [ 1813.998658] Lustre: lustre: nosquash_nids set to 192.168.204.15/24@tcp [ 1814.593155] Lustre: Unmounted lustre-client [ 1831.739427] Key type lgssc unregistered [ 1831.848519] LNet: 81958:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1831.851792] LNetError: 81958:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1831.861690] LNet: Removed LNI 192.168.204.15@tcp [ 1832.108683] Key type .llcrypt unregistered [ 1832.110034] Key type ._llcrypt unregistered [ 1837.011681] Key type ._llcrypt registered [ 1837.012751] Key type .llcrypt registered [ 1837.440366] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 08:08:17 (1784290097) [ 1838.192876] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 1838.715897] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 08:08:18 (1784290098) [ 1839.488595] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1839.493967] alg: No test for adler32 (adler32-zlib) [ 1840.340409] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1840.425348] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1842.007112] Key type lgssc registered [ 1842.345664] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1859.445067] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1861.156927] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1867.490619] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1867.633464] Lustre: lustre: root_squash is set to 500:500 [ 1867.641034] Lustre: lustre: nosquash_nids set to 192.168.204.15/24@tcp [ 1878.002497] Lustre: Mounted lustre-client [ 1880.300598] Lustre: Unmounted lustre-client [ 1897.313578] Key type lgssc unregistered [ 1897.425752] LNet: 85899:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1897.428701] LNetError: 85899:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1897.437754] LNet: Removed LNI 192.168.204.15@tcp [ 1897.681691] Key type .llcrypt unregistered [ 1897.682706] Key type ._llcrypt unregistered [ 1902.631119] Key type ._llcrypt registered [ 1902.632114] Key type .llcrypt registered [ 1903.116773] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 1903.688061] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 08:09:23 (1784290163) [ 1909.728776] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1909.735514] alg: No test for adler32 (adler32-zlib) [ 1910.582549] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 1910.663773] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 1912.247203] Key type lgssc registered [ 1912.666803] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1942.476736] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1944.509532] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1953.388484] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1983.222204] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1985.018139] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1991.544830] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2004.606508] Lustre: Mounted lustre-client [ 2017.291520] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff946f04e31000.ost_server_uuid 50 [ 2017.764283] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff946f04e31000.ost_server_uuid in FULL state after 0 sec [ 2017.888185] Lustre: Mounted lustre-client [ 2018.716671] Lustre: Unmounted lustre-client [ 2046.004749] Key type lgssc unregistered [ 2046.138568] LNet: 93530:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2046.141605] LNetError: 93530:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2046.151826] LNet: Removed LNI 192.168.204.15@tcp [ 2046.408450] Key type .llcrypt unregistered [ 2046.409517] Key type ._llcrypt unregistered [ 2056.844507] Key type ._llcrypt registered [ 2056.845547] Key type .llcrypt registered [ 2057.328677] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 08:11:57 (1784290317) [ 2063.220920] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2063.232499] alg: No test for adler32 (adler32-zlib) [ 2064.079257] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 2064.168406] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 2065.751137] Key type lgssc registered [ 2066.117528] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2096.311768] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2098.492367] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2106.770595] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2112.992288] Lustre: Mounted lustre-client [ 2128.355499] Lustre: lustre-OST0000-osc-ffff946f11b99000: Connection to lustre-OST0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2133.475782] Lustre: lustre-MDT0000-mdc-ffff946f11b99000: Connection to lustre-MDT0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2134.495190] Lustre: 94891:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784290378/real 1784290378] req@00000000edd07570 x1870964010784256/t0(0) o400->lustre-OST0000-osc-ffff946f11b99000@192.168.204.115@tcp:28/4 lens 224/224 e 0 to 1 dl 1784290394 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2139.615193] Lustre: 94891:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784290383/real 1784290383] req@00000000479ed294 x1870964010784768/t0(0) o400->lustre-OST0000-osc-ffff946f11b99000@192.168.204.115@tcp:28/4 lens 224/224 e 0 to 1 dl 1784290399 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2148.833488] LustreError: MGC192.168.204.115@tcp: Connection to MGS (at 192.168.204.115@tcp) was lost; in progress operations using this service will fail [ 2148.840344] Lustre: 98049:0:(mgc_request.c:1899:mgc_process_log()) MGC192.168.204.115@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 2148.841536] Lustre: Evicted from MGS (at 192.168.204.115@tcp) after server handle changed from 0xbdbd657179cf50fb to 0xbdbd657179cf543c [ 2148.848249] Lustre: MGC192.168.204.115@tcp: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 2150.026490] Lustre: lustre-MDT0000-mdc-ffff946f11b99000: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 2150.387810] Lustre: Unmounted lustre-client [ 2167.656350] Key type lgssc unregistered [ 2167.766314] LNet: 99169:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2167.768418] LNetError: 99169:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2167.774734] LNet: Removed LNI 192.168.204.15@tcp [ 2167.986154] Key type .llcrypt unregistered [ 2167.987253] Key type ._llcrypt unregistered [ 2172.972600] Key type ._llcrypt registered [ 2172.973546] Key type .llcrypt registered [ 2173.403334] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 08:13:53 (1784290433) [ 2184.797988] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2184.806821] alg: No test for adler32 (adler32-zlib) [ 2185.656301] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 2185.741985] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 2187.319146] Key type lgssc registered [ 2187.658102] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2202.179855] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2240.520650] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2243.213773] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2254.788442] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2256.064441] Lustre: Mounted lustre-client [ 2256.917349] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 2257.561438] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 08:15:17 (1784290517) [ 2319.910868] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2330.163943] Lustre: Unmounted lustre-client [ 2392.309963] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2394.444256] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2403.661273] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2426.291209] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 08:18:06 (1784290686) [ 2456.646356] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2458.414103] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2466.326085] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2466.480985] Lustre: Mounted lustre-client [ 2467.554127] Lustre: Unmounted lustre-client [ 2494.549850] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 08:19:14 (1784290754) [ 2528.076995] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2530.038938] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2538.611587] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2544.125544] Lustre: Mounted lustre-client [ 2545.311165] Lustre: Unmounted lustre-client [ 2570.829636] Key type lgssc unregistered [ 2570.941465] LNet: 122106:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2570.944590] LNetError: 122106:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2570.951791] LNet: Removed LNI 192.168.204.15@tcp [ 2571.209281] Key type .llcrypt unregistered [ 2571.210234] Key type ._llcrypt unregistered [ 2576.186582] Key type ._llcrypt registered [ 2576.187637] Key type .llcrypt registered [ 2576.670992] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 08:20:36 (1784290836) [ 2577.501829] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2577.510739] alg: No test for adler32 (adler32-zlib) [ 2578.364759] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 2578.454353] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 2580.039151] Key type lgssc registered [ 2580.365952] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2597.441396] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2599.135970] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2605.471758] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2615.802689] Lustre: Mounted lustre-client [ 2626.474127] Lustre: Unmounted lustre-client [ 2643.815676] Key type lgssc unregistered [ 2643.937588] LNet: 125688:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2643.940670] LNetError: 125688:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2643.950767] LNet: Removed LNI 192.168.204.15@tcp [ 2644.201191] Key type .llcrypt unregistered [ 2644.202755] Key type ._llcrypt unregistered [ 2649.496701] Key type ._llcrypt registered [ 2649.497816] Key type .llcrypt registered [ 2649.971916] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 08:21:49 (1784290909) [ 2650.622718] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2650.643056] alg: No test for adler32 (adler32-zlib) [ 2651.501317] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 2651.593078] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 2653.175185] Key type lgssc registered [ 2653.556646] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2671.736137] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2673.667987] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2680.316827] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2691.065793] Lustre: Mounted lustre-client [ 2696.164216] Lustre: lustre-OST0000-osc-ffff946f10731000: Connection to lustre-OST0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2701.737856] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff946f10731000.ost_server_uuid 50 [ 2702.290676] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 2711.611856] Lustre: Unmounted lustre-client [ 2722.158904] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 08:23:01 (1784290981) [ 2732.203249] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2734.002188] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2740.477814] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2747.981829] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2753.517893] Lustre: Mounted lustre-client [ 2758.626169] Lustre: lustre-OST0000-osc-ffff946f0777d800: Connection to lustre-OST0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2768.971447] Lustre: Unmounted lustre-client [ 2792.295224] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 08:24:12 (1784291052) [ 2802.387107] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2804.153637] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2810.631555] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2816.931465] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2817.094520] Lustre: Mounted lustre-client [ 2822.115095] Lustre: lustre-OST0000-osc-ffff946f04740800: Connection to lustre-OST0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2841.948806] Lustre: Unmounted lustre-client [ 2864.100805] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 08:25:23 (1784291123) [ 2893.107508] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2894.754483] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2902.372482] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2931.089548] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2932.772244] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2939.293494] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2960.566906] Lustre: Mounted lustre-client [ 2988.570515] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2989.111761] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 2989.456633] Lustre: Unmounted lustre-client [ 3003.727476] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 08:27:43 (1784291263) [ 3013.945647] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3015.808453] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3022.516798] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3040.715869] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3055.705602] Lustre: Mounted lustre-client [ 3083.585720] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3084.100373] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3086.306788] Lustre: lustre-OST0001-osc-ffff946f05109800: Connection to lustre-OST0001 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3087.692249] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3097.981183] Lustre: Unmounted lustre-client [ 3128.041953] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 08:29:47 (1784291387) [ 3138.248510] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3140.040521] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3146.697451] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3151.857420] Lustre: Mounted lustre-client [ 3159.907528] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3162.462835] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 2 sec [ 3167.016037] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff946f080b5000.ost_server_uuid 50 [ 3167.506837] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff946f080b5000.ost_server_uuid in FULL state after 0 sec [ 3168.117494] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3168.119541] Lustre: Skipped 3 previous similar messages [ 3168.157255] Lustre: Unmounted lustre-client [ 3168.276692] Lustre: Mounted lustre-client [ 3168.665102] LustreError: 149024:0:(sec.c:413:import_sec_validate_get()) import 000000008c2e3d76 (NEW) with no sec [ 3199.528470] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 08:30:59 (1784291459) [ 3210.069556] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3211.982165] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3218.465112] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3225.094798] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3225.227152] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 3225.228862] Lustre: Skipped 1 previous similar message [ 3225.264198] Lustre: Mounted lustre-client [ 3236.080215] Lustre: Unmounted lustre-client [ 3236.082307] Lustre: Skipped 1 previous similar message [ 3268.769844] Key type lgssc unregistered [ 3268.886438] LNet: 152434:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3268.888597] LNetError: 152434:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3268.896585] LNet: Removed LNI 192.168.204.15@tcp [ 3269.133319] Key type .llcrypt unregistered [ 3269.134203] Key type ._llcrypt unregistered [ 3273.974239] Key type ._llcrypt registered [ 3273.975646] Key type .llcrypt registered [ 3274.440604] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 08:32:14 (1784291534) [ 3274.828424] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3274.835965] alg: No test for adler32 (adler32-zlib) [ 3275.691515] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 3275.776575] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 3277.367161] Key type lgssc registered [ 3277.756126] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3295.756282] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3297.389506] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3303.424864] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3309.749731] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3309.866329] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3315.185104] Lustre: Mounted lustre-client [ 3321.835426] LustreError: lustre-MDT0001-mdc-ffff946f04eaa800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 3321.841441] Lustre: lustre-MDT0001-mdc-ffff946f04eaa800: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 3324.590190] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3325.080921] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 3335.142094] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3342.033491] Lustre: Unmounted lustre-client [ 3360.687496] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 08:33:40 (1784291620) [ 3390.118254] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3391.804483] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3399.278934] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3399.429612] Lustre: Mounted lustre-client [ 3409.810830] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3410.371890] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3427.722556] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3438.011117] Lustre: Unmounted lustre-client [ 3469.622439] Key type lgssc unregistered [ 3469.747566] LNet: 162028:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3469.750531] LNetError: 162028:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3469.760749] LNet: Removed LNI 192.168.204.15@tcp [ 3469.990978] Key type .llcrypt unregistered [ 3469.992281] Key type ._llcrypt unregistered [ 3479.753585] Key type ._llcrypt registered [ 3479.754388] Key type .llcrypt registered [ 3480.183867] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 08:35:39 (1784291739) [ 3480.955849] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3480.963798] alg: No test for adler32 (adler32-zlib) [ 3481.812136] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 3481.894039] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 3483.479206] Key type lgssc registered [ 3483.869339] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3500.739845] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3502.427503] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3508.440015] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3514.842118] Lustre: Mounted lustre-client [ 3552.073213] Lustre: Unmounted lustre-client [ 3568.510285] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3568.645670] Lustre: Mounted lustre-client [ 3600.784284] Lustre: Unmounted lustre-client [ 3618.123841] Key type lgssc unregistered [ 3618.238542] LNet: 166457:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3618.242108] LNetError: 166457:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3618.251754] LNet: Removed LNI 192.168.204.15@tcp [ 3618.517609] Key type .llcrypt unregistered [ 3618.519648] Key type ._llcrypt unregistered [ 3623.806624] Key type ._llcrypt registered [ 3623.808083] Key type .llcrypt registered [ 3624.280531] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 08:38:03 (1784291883) [ 3625.064675] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3625.070636] alg: No test for adler32 (adler32-zlib) [ 3625.929656] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 3626.025359] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 3627.615197] Key type lgssc registered [ 3627.980763] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3645.562862] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3647.199058] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3653.418795] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3663.854721] Lustre: Mounted lustre-client [ 3670.601163] Lustre: Unmounted lustre-client [ 3687.633662] Key type lgssc unregistered [ 3687.744540] LNet: 170196:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3687.747952] LNetError: 170196:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3687.756625] LNet: Removed LNI 192.168.204.15@tcp [ 3688.005370] Key type .llcrypt unregistered [ 3688.006412] Key type ._llcrypt unregistered [ 3691.991232] Key type ._llcrypt registered [ 3691.992463] Key type .llcrypt registered [ 3692.166443] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3692.173831] alg: No test for adler32 (adler32-zlib) [ 3693.031978] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 3693.116974] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 3694.695188] Key type lgssc registered [ 3695.065143] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3712.177875] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3713.965803] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3720.282436] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3730.928675] Lustre: Mounted lustre-client [ 3733.698152] Lustre: Unmounted lustre-client [ 3746.725794] Key type lgssc unregistered [ 3746.850659] LNet: 173252:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3746.853355] LNetError: 173252:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3746.860501] LNet: Removed LNI 192.168.204.15@tcp [ 3747.084579] Key type .llcrypt unregistered [ 3747.085652] Key type ._llcrypt unregistered [ 3751.800900] Key type ._llcrypt registered [ 3751.801814] Key type .llcrypt registered [ 3752.212813] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 08:40:11 (1784292011) [ 3752.958286] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3752.974259] alg: No test for adler32 (adler32-zlib) [ 3753.829300] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 3753.916361] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 3755.503120] Key type lgssc registered [ 3755.880713] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3772.909183] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3774.617602] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3781.351441] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3791.861267] Lustre: Mounted lustre-client [ 3798.627168] Lustre: Unmounted lustre-client [ 3815.545556] Key type lgssc unregistered [ 3815.655520] LNet: 176989:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3815.657668] LNetError: 176989:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3815.663917] LNet: Removed LNI 192.168.204.15@tcp [ 3815.903265] Key type .llcrypt unregistered [ 3815.904232] Key type ._llcrypt unregistered [ 3819.579357] Key type ._llcrypt registered [ 3819.580432] Key type .llcrypt registered [ 3819.722110] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3819.727958] alg: No test for adler32 (adler32-zlib) [ 3820.568737] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 3820.644638] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 3822.223190] Key type lgssc registered [ 3822.589551] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3840.376526] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3842.150501] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3848.769886] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3859.441966] Lustre: Mounted lustre-client [ 3862.307483] Lustre: Unmounted lustre-client [ 3887.770481] Key type lgssc unregistered [ 3887.886598] LNet: 180041:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3887.891138] LNetError: 180041:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3887.900684] LNet: Removed LNI 192.168.204.15@tcp [ 3888.179732] Key type .llcrypt unregistered [ 3888.181646] Key type ._llcrypt unregistered [ 3893.825335] Key type ._llcrypt registered [ 3893.826622] Key type .llcrypt registered [ 3894.278975] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 08:42:34 (1784292154) [ 3901.081570] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3901.089895] alg: No test for adler32 (adler32-zlib) [ 3901.946745] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 3902.028798] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 3903.607123] Key type lgssc registered [ 3903.959596] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3932.819830] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3934.575589] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3942.490186] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3966.677969] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 08:43:46 (1784292226) [ 3976.999276] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3978.812590] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3985.580306] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3996.145655] Lustre: Mounted lustre-client [ 3998.086647] Lustre: Unmounted lustre-client [ 4015.383392] Key type lgssc unregistered [ 4015.499588] LNet: 187109:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4015.501816] LNetError: 187109:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4015.509787] LNet: Removed LNI 192.168.204.15@tcp [ 4015.759731] Key type .llcrypt unregistered [ 4015.761494] Key type ._llcrypt unregistered [ 4020.777516] Key type ._llcrypt registered [ 4020.778686] Key type .llcrypt registered [ 4021.214267] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 4021.758919] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 08:44:41 (1784292281) [ 4027.502539] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4027.519729] alg: No test for adler32 (adler32-zlib) [ 4028.372183] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 4028.468049] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 4030.055191] Key type lgssc registered [ 4030.457260] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4061.876402] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4063.590809] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4071.283826] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4077.589856] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4078.755490] Lustre: Mounted lustre-client [ 4084.699607] Lustre: Unmounted lustre-client [ 4145.355640] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4147.143025] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4155.275786] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4176.533429] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 08:47:16 (1784292436) [ 4177.059864] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 4177.616681] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 08:47:17 (1784292437) [ 4219.941054] Key type lgssc unregistered [ 4220.048530] LNet: 198497:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4220.052850] LNetError: 198497:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4220.060807] LNet: Removed LNI 192.168.204.15@tcp [ 4220.283325] Key type .llcrypt unregistered [ 4220.284438] Key type ._llcrypt unregistered [ 4225.079699] Key type ._llcrypt registered [ 4225.080624] Key type .llcrypt registered [ 4225.495183] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 08:48:05 (1784292485) [ 4247.445743] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4247.482551] alg: No test for adler32 (adler32-zlib) [ 4248.334619] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 4248.418967] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 4250.007123] Key type lgssc registered [ 4250.362143] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4264.550663] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4266.226482] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4285.835603] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4296.955773] Key type lgssc unregistered [ 4297.071295] LNet: 202213:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4297.073445] LNetError: 202213:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4297.084281] LNet: Removed LNI 192.168.204.15@tcp [ 4297.313640] Key type .llcrypt unregistered [ 4297.314753] Key type ._llcrypt unregistered [ 4302.457560] Key type ._llcrypt registered [ 4302.458887] Key type .llcrypt registered [ 4302.909258] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 08:49:22 (1784292562) [ 4303.753145] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4303.760589] alg: No test for adler32 (adler32-zlib) [ 4304.620184] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 4304.711838] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 4306.295122] Key type lgssc registered [ 4306.672635] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4328.392995] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4331.013941] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4344.002699] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4346.375747] Lustre: Mounted lustre-client [ 4356.580155] Lustre: lustre-MDT0000-mdc-ffff946f11bde000: Connection to lustre-MDT0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4361.716356] Lustre: lustre-MDT0001-mdc-ffff946f11bde000: Connection to lustre-MDT0001 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4376.991157] Lustre: 203203:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784292621/real 1784292621] req@000000009d2fb0fd x1870966359671040/t0(0) o400->MGC192.168.204.115@tcp@192.168.204.115@tcp:26/25 lens 224/224 e 0 to 1 dl 1784292637 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4377.005090] LustreError: MGC192.168.204.115@tcp: Connection to MGS (at 192.168.204.115@tcp) was lost; in progress operations using this service will fail [ 4377.018872] Lustre: Evicted from MGS (at 192.168.204.115@tcp) after server handle changed from 0xc1599323f4e31101 to 0xc1599323f4e32a45 [ 4377.023508] Lustre: MGC192.168.204.115@tcp: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 4382.690407] Lustre: 205318:0:(mgc_request.c:1899:mgc_process_log()) MGC192.168.204.115@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 4395.637273] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4397.539053] LustreError: lustre-MDT0000-mdc-ffff946f11bde000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 4397.559927] Lustre: lustre-MDT0000-mdc-ffff946f11bde000: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 4398.311429] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 2 sec [ 4400.293450] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4400.930281] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4401.657673] Lustre: Unmounted lustre-client [ 4419.200766] Key type lgssc unregistered [ 4419.325735] LNet: 207157:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4419.329379] LNetError: 207157:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4419.339596] LNet: Removed LNI 192.168.204.15@tcp [ 4419.614329] Key type .llcrypt unregistered [ 4419.615565] Key type ._llcrypt unregistered [ 4424.883831] Key type ._llcrypt registered [ 4424.884884] Key type .llcrypt registered [ 4425.337050] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 08:51:25 (1784292685) [ 4426.103478] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4426.149523] alg: No test for adler32 (adler32-zlib) [ 4426.999482] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 4427.079935] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 4428.655161] Key type lgssc registered [ 4429.039512] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4446.969906] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4448.867573] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4472.032353] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4474.131339] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4488.947228] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4495.787863] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4514.668425] Key type lgssc unregistered [ 4514.775321] LNet: 212430:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4514.777560] LNetError: 212430:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4514.787251] LNet: Removed LNI 192.168.204.15@tcp [ 4514.991981] Key type .llcrypt unregistered [ 4514.993082] Key type ._llcrypt unregistered [ 4535.521921] Key type ._llcrypt registered [ 4535.523745] Key type .llcrypt registered [ 4535.976015] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 08:53:15 (1784292795) [ 4547.708202] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4547.744640] alg: No test for adler32 (adler32-zlib) [ 4548.600346] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 4548.693296] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 4550.279125] Key type lgssc registered [ 4550.627263] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4578.791760] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4580.540968] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4588.329561] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4619.177207] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 08:54:38 (1784292878) [ 4621.466056] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 08:54:41 (1784292881) [ 4631.582118] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4633.211786] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4639.138745] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4654.575238] Lustre: Mounted lustre-client [ 4657.643909] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 4658.300663] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 4658.776993] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 4659.298565] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 4664.801739] Lustre: lustre-MDT0000-mdc-ffff946f0916b800: Connection to lustre-MDT0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4675.042682] LustreError: MGC192.168.204.115@tcp: Connection to MGS (at 192.168.204.115@tcp) was lost; in progress operations using this service will fail [ 4675.051285] Lustre: Evicted from MGS (at 192.168.204.115@tcp) after server handle changed from 0x9eedea8a021067f8 to 0x9eedea8a02106a8a [ 4675.056614] Lustre: MGC192.168.204.115@tcp: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 4678.285013] Lustre: lustre-MDT0000-mdc-ffff946f0916b800: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 4679.930673] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4680.428975] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4682.274259] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 4685.281755] Lustre: lustre-MDT0000-mdc-ffff946f0916b800: Connection to lustre-MDT0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4700.639153] Lustre: 220286:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1784292944/real 1784292944] req@00000000ebf14116 x1870966615456384/t0(0) o101->MGC192.168.204.115@tcp@192.168.204.115@tcp:26/25 lens 328/344 e 0 to 1 dl 1784292960 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4700.648197] LustreError: MGC192.168.204.115@tcp: Connection to MGS (at 192.168.204.115@tcp) was lost; in progress operations using this service will fail [ 4700.652740] Lustre: 220286:0:(mgc_request.c:1899:mgc_process_log()) MGC192.168.204.115@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 4700.657303] Lustre: Evicted from MGS (at 192.168.204.115@tcp) after server handle changed from 0x9eedea8a02106a8a to 0x9eedea8a02106d7e [ 4700.660471] Lustre: MGC192.168.204.115@tcp: Connection restored to 192.168.204.115@tcp (at 192.168.204.115@tcp) [ 4703.125328] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4703.666789] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4705.253580] Lustre: Unmounted lustre-client [ 4737.992536] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4739.837235] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4746.528855] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4756.975432] Lustre: Mounted lustre-client [ 4757.299901] Lustre: Unmounted lustre-client [ 4774.587840] Key type lgssc unregistered [ 4774.719590] LNet: 224857:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4774.722413] LNetError: 224857:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4774.731915] LNet: Removed LNI 192.168.204.15@tcp [ 4774.987851] Key type .llcrypt unregistered [ 4774.988996] Key type ._llcrypt unregistered [ 4779.864672] Key type ._llcrypt registered [ 4779.865892] Key type .llcrypt registered [ 4780.297919] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 08:57:20 (1784293040) [ 4781.521771] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4781.551077] alg: No test for adler32 (adler32-zlib) [ 4782.399950] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 4782.487459] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 4784.063207] Key type lgssc registered [ 4784.446499] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4801.102082] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4802.718462] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4809.375297] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4819.952129] Lustre: Mounted lustre-client [ 4822.882841] Lustre: Unmounted lustre-client [ 4854.176143] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4855.944706] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4862.611495] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4873.201450] Lustre: Mounted lustre-client [ 4879.349122] Lustre: Unmounted lustre-client [ 4912.490642] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4914.365100] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4920.731426] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4931.061051] Lustre: Mounted lustre-client [ 4931.383824] Lustre: Unmounted lustre-client [ 4948.578833] Key type lgssc unregistered [ 4948.695555] LNet: 231876:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4948.697761] LNetError: 231876:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4948.706518] LNet: Removed LNI 192.168.204.15@tcp [ 4948.947656] Key type .llcrypt unregistered [ 4948.949273] Key type ._llcrypt unregistered [ 4954.087513] Key type ._llcrypt registered [ 4954.089298] Key type .llcrypt registered [ 4954.537374] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 09:00:14 (1784293214) [ 4955.633140] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4955.639607] alg: No test for adler32 (adler32-zlib) [ 4956.499132] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 4956.592950] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 4958.183177] Key type lgssc registered [ 4958.541139] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4973.808503] Key type lgssc unregistered [ 4973.925333] LNet: 234191:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4973.928311] LNetError: 234191:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4973.935310] LNet: Removed LNI 192.168.204.15@tcp [ 4974.199833] Key type .llcrypt unregistered [ 4974.201016] Key type ._llcrypt unregistered [ 4983.175311] Key type ._llcrypt registered [ 4983.176964] Key type .llcrypt registered [ 4983.350493] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4983.367503] alg: No test for adler32 (adler32-zlib) [ 4984.219588] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 4984.304612] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 4985.887140] Key type lgssc registered [ 4986.261942] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5014.325093] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5016.147759] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5023.616305] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5047.256236] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 5047.735581] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 09:01:47 (1784293307) [ 5057.812297] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5059.551444] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5066.081273] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5073.646943] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5079.024038] Lustre: Mounted lustre-client [ 5084.131289] Lustre: lustre-OST0001-osc-ffff946f10ce4000: Connection to lustre-OST0001 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5086.571458] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5096.824124] Lustre: Unmounted lustre-client [ 5136.725858] Key type lgssc unregistered [ 5136.845584] LNet: 241287:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5136.849312] LNetError: 241287:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5136.857876] LNet: Removed LNI 192.168.204.15@tcp [ 5137.102857] Key type .llcrypt unregistered [ 5137.103958] Key type ._llcrypt unregistered [ 5147.306783] Key type ._llcrypt registered [ 5147.307616] Key type .llcrypt registered [ 5147.681932] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 09:03:27 (1784293407) [ 5151.499886] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5151.518511] alg: No test for adler32 (adler32-zlib) [ 5152.353917] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 5152.426612] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 5153.999112] Key type lgssc registered [ 5154.369075] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5171.975792] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5173.571542] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5184.729083] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 09:04:04 (1784293444) [ 5194.896095] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5196.595854] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5202.965738] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5209.561898] Lustre: Mounted lustre-client [ 5214.254108] Lustre: Unmounted lustre-client [ 5262.059066] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5263.863322] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5295.182823] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5305.839670] Lustre: Mounted lustre-client [ 5306.260581] Lustre: Unmounted lustre-client [ 5323.308596] Key type lgssc unregistered [ 5323.418540] LNet: 248978:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5323.421372] LNetError: 248978:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5323.429636] LNet: Removed LNI 192.168.204.15@tcp [ 5323.654857] Key type .llcrypt unregistered [ 5323.656039] Key type ._llcrypt unregistered [ 5332.777841] Key type ._llcrypt registered [ 5332.778857] Key type .llcrypt registered [ 5332.931049] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5332.952349] alg: No test for adler32 (adler32-zlib) [ 5333.801561] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 5333.888765] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 5335.471222] Key type lgssc registered [ 5335.854119] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5367.457704] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5370.241559] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5381.857949] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5406.504734] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 5407.109892] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 09:07:46 (1784293666) [ 5418.230935] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5420.156273] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5426.751881] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5438.454983] Lustre: Mounted lustre-client [ 5439.390632] Lustre: Unmounted lustre-client [ 5456.656139] Key type lgssc unregistered [ 5456.786588] LNet: 255585:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5456.788918] LNetError: 255585:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5456.797332] LNet: Removed LNI 192.168.204.15@tcp [ 5457.042691] Key type .llcrypt unregistered [ 5457.044079] Key type ._llcrypt unregistered [ 5462.104445] Key type ._llcrypt registered [ 5462.105334] Key type .llcrypt registered [ 5462.575350] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 5463.134498] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 09:08:42 (1784293722) [ 5466.132478] Key type .llcrypt unregistered [ 5466.133915] Key type ._llcrypt unregistered [ 5468.989555] Key type ._llcrypt registered [ 5468.990752] Key type .llcrypt registered [ 5469.192135] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5469.199657] alg: No test for adler32 (adler32-zlib) [ 5470.067728] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 5470.159491] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 5471.751228] Key type lgssc registered [ 5472.187483] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5492.082517] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5501.935565] Lustre: Mounted lustre-client [ 5502.376119] Lustre: Unmounted lustre-client [ 5519.693979] Key type lgssc unregistered [ 5519.817581] LNet: 259025:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5519.822662] LNetError: 259025:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5519.838403] LNet: Removed LNI 192.168.204.15@tcp [ 5520.108381] Key type .llcrypt unregistered [ 5520.110042] Key type ._llcrypt unregistered [ 5525.488385] Key type ._llcrypt registered [ 5525.489657] Key type .llcrypt registered [ 5525.965651] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 09:09:45 (1784293785) [ 5526.654834] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5526.661658] alg: No test for adler32 (adler32-zlib) [ 5527.513789] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 5527.603192] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 5529.191164] Key type lgssc registered [ 5529.575451] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5590.251330] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5600.316150] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5602.227478] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5603.392876] Lustre: Mounted lustre-client [ 5603.859133] Lustre: Unmounted lustre-client [ 5621.175589] Key type lgssc unregistered [ 5621.306165] LNet: 262558:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5621.310298] LNetError: 262558:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5621.318668] LNet: Removed LNI 192.168.204.15@tcp [ 5621.597771] Key type .llcrypt unregistered [ 5621.599483] Key type ._llcrypt unregistered [ 5627.189146] Key type ._llcrypt registered [ 5627.190519] Key type .llcrypt registered [ 5627.653430] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 09:11:27 (1784293887) [ 5628.453469] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5628.464322] alg: No test for adler32 (adler32-zlib) [ 5629.323444] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 5629.418177] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 5630.999173] Key type lgssc registered [ 5631.411180] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5650.085138] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5651.958935] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5659.043114] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5669.364961] Lustre: Mounted lustre-client [ 5674.466865] Lustre: lustre-MDT0000-mdc-ffff946f04741800: Connection to lustre-MDT0000 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5677.066695] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5677.078550] LustreError: 265702:0:(file.c:6088:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 5677.187445] LustreError: MGC192.168.204.115@tcp: Connection to MGS (at 192.168.204.115@tcp) was lost; in progress operations using this service will fail [ 5677.212163] Lustre: Unmounted lustre-client [ 5687.943761] Key type lgssc unregistered [ 5688.061430] LNet: 266114:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5688.065429] LNetError: 266114:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5688.074287] LNet: Removed LNI 192.168.204.15@tcp [ 5688.324607] Key type .llcrypt unregistered [ 5688.325890] Key type ._llcrypt unregistered [ 5694.019700] Key type ._llcrypt registered [ 5694.021181] Key type .llcrypt registered [ 5694.502551] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 09:12:34 (1784293954) [ 5695.286088] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5695.295734] alg: No test for adler32 (adler32-zlib) [ 5696.170702] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 5696.263983] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 5697.847200] Key type lgssc registered [ 5698.201577] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5716.188916] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5718.113762] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5724.930511] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5735.408852] Lustre: Mounted lustre-client [ 5740.514188] Lustre: lustre-MDT0001-mdc-ffff946f119e8000: Connection to lustre-MDT0001 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5743.094665] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5743.422135] Lustre: Unmounted lustre-client [ 5754.180127] Key type lgssc unregistered [ 5754.293551] LNet: 269680:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5754.297209] LNetError: 269680:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5754.306370] LNet: Removed LNI 192.168.204.15@tcp [ 5754.540683] Key type .llcrypt unregistered [ 5754.541799] Key type ._llcrypt unregistered [ 5759.631581] Key type ._llcrypt registered [ 5759.632847] Key type .llcrypt registered [ 5760.075516] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 09:13:39 (1784294019) [ 5765.960162] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5765.982184] alg: No test for adler32 (adler32-zlib) [ 5766.828067] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 5766.913214] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 5768.495146] Key type lgssc registered [ 5768.858977] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5807.359367] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5813.721742] Lustre: Mounted lustre-client [ 5829.603517] Lustre: lustre-MDT0001-mdc-ffff946f04742000: Connection to lustre-MDT0001 (at 192.168.204.115@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5836.736582] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5847.029794] Lustre: Unmounted lustre-client [ 5864.067048] Key type lgssc unregistered [ 5864.186628] LNet: 275444:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5864.189082] LNetError: 275444:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5864.196660] LNet: Removed LNI 192.168.204.15@tcp [ 5864.442894] Key type .llcrypt unregistered [ 5864.445176] Key type ._llcrypt unregistered [ 5869.598284] Key type ._llcrypt registered [ 5869.599194] Key type .llcrypt registered [ 5870.029938] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 09:15:29 (1784294129) [ 5870.596584] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 5871.102492] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 09:15:30 (1784294130) [ 5871.608658] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 5872.144389] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 09:15:31 (1784294131) [ 5872.692419] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 5873.256664] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 09:15:33 (1784294133) [ 5873.807203] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 5874.345544] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 09:15:34 (1784294134) [ 5874.913758] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 5875.499391] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 09:15:35 (1784294135) [ 5878.342504] Key type .llcrypt unregistered [ 5878.343761] Key type ._llcrypt unregistered [ 5880.622862] Key type ._llcrypt registered [ 5880.624674] Key type .llcrypt registered [ 5880.804966] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5880.810849] alg: No test for adler32 (adler32-zlib) [ 5881.673427] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 5881.781711] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 5883.367267] Key type lgssc registered [ 5883.773851] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5911.082365] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5912.956479] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5920.966896] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5922.159755] Lustre: Mounted lustre-client [ 5922.635119] Lustre: Unmounted lustre-client [ 5944.744878] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 09:16:44 (1784294204) [ 5955.084491] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5956.833122] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5975.911982] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5976.056543] Lustre: Mounted lustre-client [ 5976.369426] Lustre: Unmounted lustre-client [ 6013.972180] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 09:17:53 (1784294273) [ 6029.279150] LNet: 1 local NIs in recovery (showing 1): 192.168.204.15@tcp [ 6601.114368] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6602.988140] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6622.833355] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6669.991835] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 09:28:49 (1784294929) [ 6673.504531] Key type lgssc unregistered [ 6673.617532] LNet: 288918:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6673.619540] LNetError: 288918:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6673.628724] LNet: Removed LNI 192.168.204.15@tcp [ 6673.837916] Key type .llcrypt unregistered [ 6673.838854] Key type ._llcrypt unregistered [ 6747.809745] Key type ._llcrypt registered [ 6747.810892] Key type .llcrypt registered [ 6747.986786] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6747.992355] alg: No test for adler32 (adler32-zlib) [ 6748.849995] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 6748.942666] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 6750.519206] Key type lgssc registered [ 6750.924381] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6782.893334] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6784.730784] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6792.188086] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6804.647229] Key type lgssc unregistered [ 6804.759301] LNet: 292591:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6804.761704] LNetError: 292591:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6804.773364] LNet: Removed LNI 192.168.204.15@tcp [ 6804.998753] Key type .llcrypt unregistered [ 6804.999930] Key type ._llcrypt unregistered [ 6833.169943] Key type ._llcrypt registered [ 6833.171173] Key type .llcrypt registered [ 6833.622822] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 09:31:33 (1784295093) [ 6840.452598] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6840.460973] alg: No test for adler32 (adler32-zlib) [ 6841.332914] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 6841.427573] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 6843.015081] Key type lgssc registered [ 6843.406834] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6860.552548] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 09:32:00 (1784295120) [ 6864.469180] Key type lgssc unregistered [ 6864.578472] LNet: 296138:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6864.580774] LNetError: 296138:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6864.587378] LNet: Removed LNI 192.168.204.15@tcp [ 6864.840752] Key type .llcrypt unregistered [ 6864.842033] Key type ._llcrypt unregistered [ 6868.530816] Key type ._llcrypt registered [ 6868.531974] Key type .llcrypt registered [ 6868.721054] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6868.727290] alg: No test for adler32 (adler32-zlib) [ 6869.607188] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 6869.707265] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 6871.295167] Key type lgssc registered [ 6871.665160] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6892.645547] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6894.483790] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6902.190329] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6981.517731] LNet: Added LNI 192.168.204.15@tcp50 [8/256/0/180] [ 6982.206705] LNet: Removed LNI 192.168.204.15@tcp [ 6983.531725] Lustre: 300494:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff946f05a98000: config has no valid NIDs, force dynamic NIDs [ 6984.577110] Lustre: Mounted lustre-client [ 6984.632843] Lustre: Unmounted lustre-client [ 6985.554819] Key type lgssc unregistered [ 6985.701914] LNet: 300754:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6985.704214] LNetError: 300754:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6985.715296] LNet: Removed LNI 192.168.204.15@tcp50 [ 6985.941172] Key type .llcrypt unregistered [ 6985.942312] Key type ._llcrypt unregistered [ 6995.844122] Key type ._llcrypt registered [ 6995.849023] Key type .llcrypt registered [ 6996.020247] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6996.027881] alg: No test for adler32 (adler32-zlib) [ 6996.886851] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 6996.989689] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 6998.575154] Key type lgssc registered [ 6999.002560] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7013.060379] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7014.897593] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7017.340793] LNet: Added LNI 192.168.204.15@tcp50 [8/256/0/180] [ 7017.627840] LNet: Removed LNI 192.168.204.15@tcp [ 7018.735336] Lustre: 303435:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff946f09011000: config has no valid NIDs, force dynamic NIDs [ 7019.787803] Lustre: Mounted lustre-client [ 7019.953136] Lustre: Unmounted lustre-client [ 7038.817443] Key type lgssc unregistered [ 7038.965418] LNet: 304303:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7038.969776] LNetError: 304303:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7038.981554] LNet: Removed LNI 192.168.204.15@tcp50 [ 7039.205123] Key type .llcrypt unregistered [ 7039.206259] Key type ._llcrypt unregistered [ 7043.059104] Key type ._llcrypt registered [ 7043.060280] Key type .llcrypt registered [ 7043.524157] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 09:35:03 (1784295303) [ 7049.377573] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7049.392644] alg: No test for adler32 (adler32-zlib) [ 7050.264294] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 7050.347207] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 7051.927137] Key type lgssc registered [ 7052.317293] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7080.515858] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7082.207079] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7090.223232] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7108.904699] Key type lgssc unregistered [ 7109.027497] LNet: 309028:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7109.032062] LNetError: 309028:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7109.039510] LNet: Removed LNI 192.168.204.15@tcp [ 7109.278109] Key type .llcrypt unregistered [ 7109.279297] Key type ._llcrypt unregistered [ 7112.803304] Key type ._llcrypt registered [ 7112.804445] Key type .llcrypt registered [ 7113.247320] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 09:36:12 (1784295372) [ 7114.087303] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7114.092400] alg: No test for adler32 (adler32-zlib) [ 7114.946544] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 7115.042572] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 7116.623179] Key type lgssc registered [ 7117.031905] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7135.201291] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7137.033766] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7143.832429] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7154.161438] Lustre: Mounted lustre-client [ 7173.980505] Lustre: Mounted fs15246-client [ 7178.364968] Lustre: Unmounted fs15246-client [ 7190.486432] Lustre: Unmounted lustre-client [ 7215.947108] Key type lgssc unregistered [ 7216.081560] LNet: 313864:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7216.086229] LNetError: 313864:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7216.101553] LNet: Removed LNI 192.168.204.15@tcp [ 7216.389425] Key type .llcrypt unregistered [ 7216.391265] Key type ._llcrypt unregistered [ 7220.298639] Key type ._llcrypt registered [ 7220.299680] Key type .llcrypt registered [ 7220.766866] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 09:38:00 (1784295480) [ 7221.401078] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7221.408811] alg: No test for adler32 (adler32-zlib) [ 7222.272493] Lustre: Lustre: Build Version: 2.17.54_173_g0a24909 [ 7222.374906] LNet: Added LNI 192.168.204.15@tcp [8/256/0/180] [ 7223.959172] Key type lgssc registered [ 7224.361098] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7268.932602] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7270.738651] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7279.027512] Lustre: DEBUG MARKER: oleg415-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7319.713937] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 7197 sec ========== 09:39:39 (1784295579) [ 7320.234318] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 09:39:39 (1784295579) === [ 7321.306030] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 09:39:41 (1784295581) === [ 7332.441502] Key type lgssc unregistered [ 7332.566524] LNet: 323090:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7332.570452] LNetError: 323090:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7332.582477] LNet: Removed LNI 192.168.204.15@tcp [ 7332.842741] Key type .llcrypt unregistered [ 7332.843944] Key type ._llcrypt unregistered