[ 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 438413071 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003117] x2apic enabled [ 0.004009] Switched APIC routing to physical x2apic. [ 0.005018] kvm-guest: setup PV IPIs [ 0.008364] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010026] pid_max: default: 32768 minimum: 301 [ 0.011142] LSM: Security Framework initializing [ 0.012067] Yama: becoming mindful. [ 0.013040] SELinux: Initializing. [ 0.015002] *** VALIDATE selinux *** [ 0.023252] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027803] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028172] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029134] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030130] *** VALIDATE tmpfs *** [ 0.031496] *** VALIDATE proc *** [ 0.033080] *** VALIDATE cgroup *** [ 0.034011] *** VALIDATE cgroup2 *** [ 0.035273] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036177] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038033] Spectre V2 : User space: Vulnerable [ 0.039014] Speculative Store Bypass: Vulnerable [ 0.042649] debug: unmapping init [mem 0xffffffff92e59000-0xffffffff92e60fff] [ 0.044192] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.045728] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.046026] ... version: 2 [ 0.047012] ... bit width: 48 [ 0.048016] ... generic registers: 4 [ 0.049014] ... value mask: 0000ffffffffffff [ 0.050018] ... max period: 00007fffffffffff [ 0.051018] ... fixed-purpose events: 3 [ 0.052014] ... event mask: 000000070000000f [ 0.053352] rcu: Hierarchical SRCU implementation. [ 0.055517] smp: Bringing up secondary CPUs ... [ 0.056604] x86: Booting SMP configuration: [ 0.057030] .... node #0, CPUs: #1 #2 #3 [ 0.061115] smp: Brought up 1 node, 4 CPUs [ 0.063019] smpboot: Max logical packages: 1 [ 0.064012] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.152670] node 0 deferred pages initialised in 86ms [ 0.156009] devtmpfs: initialized [ 0.157241] x86/mm: Memory block size: 128MB [ 0.159814] gcov: version magic: 0x41383552 [ 0.160636] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.164086] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.167324] pinctrl core: initialized pinctrl subsystem [ 0.169180] [ 0.169778] ************************************************************* [ 0.171020] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.172008] ** ** [ 0.174013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.176011] ** ** [ 0.178012] ** This means that this kernel is built to expose internal ** [ 0.180012] ** IOMMU data structures, which may compromise security on ** [ 0.182013] ** your system. ** [ 0.184011] ** ** [ 0.186013] ** If you see this message and you are not debugging the ** [ 0.187007] ** kernel, report this immediately to your vendor! ** [ 0.189013] ** ** [ 0.190007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.191008] ************************************************************* [ 0.193518] NET: Registered protocol family 16 [ 0.194388] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.196070] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.199058] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.201112] cpuidle: using governor menu [ 0.202469] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.204394] PCI: Using configuration type 1 for base access [ 0.206143] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.216133] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.219025] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.222083] cryptd: max_cpu_qlen set to 1000 [ 0.224198] ACPI: Added _OSI(Module Device) [ 0.225009] ACPI: Added _OSI(Processor Device) [ 0.226009] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.227008] ACPI: Added _OSI(Processor Aggregator Device) [ 0.231219] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.235343] ACPI: Interpreter enabled [ 0.237043] ACPI: PM: (supports S0 S3 S4 S5) [ 0.237979] ACPI: Using IOAPIC for interrupt routing [ 0.239079] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.241377] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.251000] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.253039] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.255015] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.258093] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.262330] acpiphp: Slot [2] registered [ 0.263076] acpiphp: Slot [5] registered [ 0.264107] acpiphp: Slot [6] registered [ 0.265036] acpiphp: Slot [3] registered [ 0.266024] acpiphp: Slot [4] registered [ 0.267023] acpiphp: Slot [7] registered [ 0.268094] acpiphp: Slot [8] registered [ 0.270100] acpiphp: Slot [9] registered [ 0.271093] acpiphp: Slot [10] registered [ 0.272135] acpiphp: Slot [11] registered [ 0.274106] acpiphp: Slot [12] registered [ 0.275107] acpiphp: Slot [13] registered [ 0.276087] acpiphp: Slot [14] registered [ 0.277062] acpiphp: Slot [15] registered [ 0.279097] acpiphp: Slot [16] registered [ 0.280088] acpiphp: Slot [17] registered [ 0.281087] acpiphp: Slot [18] registered [ 0.282118] acpiphp: Slot [19] registered [ 0.283087] acpiphp: Slot [20] registered [ 0.284086] acpiphp: Slot [21] registered [ 0.285111] acpiphp: Slot [22] registered [ 0.286080] acpiphp: Slot [23] registered [ 0.287081] acpiphp: Slot [24] registered [ 0.288086] acpiphp: Slot [25] registered [ 0.289100] acpiphp: Slot [26] registered [ 0.291074] acpiphp: Slot [27] registered [ 0.291948] acpiphp: Slot [28] registered [ 0.292875] acpiphp: Slot [29] registered [ 0.294061] acpiphp: Slot [30] registered [ 0.294971] acpiphp: Slot [31] registered [ 0.295044] PCI host bridge to bus 0000:00 [ 0.295895] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.297017] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.299014] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.300018] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.302015] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.303019] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.304137] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.306785] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.308907] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.313384] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.316423] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.318013] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.319011] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.321014] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.323197] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.325869] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.328042] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.330985] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.335016] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.344618] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.348013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.352779] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.364019] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.374026] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.391019] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.400172] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.406022] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.411022] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.423021] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.430912] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.432314] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.434241] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.435295] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.437141] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.440105] iommu: Default domain type: Passthrough [ 0.441367] SCSI subsystem initialized [ 0.443165] ACPI: bus type USB registered [ 0.444093] usbcore: registered new interface driver usbfs [ 0.446080] usbcore: registered new interface driver hub [ 0.447073] usbcore: registered new device driver usb [ 0.449167] pps_core: LinuxPPS API ver. 1 registered [ 0.451011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.453077] PTP clock support registered [ 0.455133] EDAC MC: Ver: 3.0.0 [ 0.457144] PCI: Using ACPI for IRQ routing [ 0.458613] NetLabel: Initializing [ 0.460009] NetLabel: domain hash size = 128 [ 0.460876] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.462058] NetLabel: unlabeled traffic allowed by default [ 0.463103] vgaarb: loaded [ 0.464268] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.466012] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.472000] clocksource: Switched to clocksource kvm-clock [ 0.571426] VFS: Disk quotas dquot_6.6.0 [ 0.573037] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.574982] *** VALIDATE ramfs *** [ 0.575646] *** VALIDATE hugetlbfs *** [ 0.576849] pnp: PnP ACPI init [ 0.579180] pnp: PnP ACPI: found 6 devices [ 0.595060] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.597109] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.598807] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.600223] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.602621] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.604596] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.607181] NET: Registered protocol family 2 [ 0.609171] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.613461] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.616547] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.621707] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.624757] TCP: Hash tables configured (established 65536 bind 65536) [ 0.627265] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.629345] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.631479] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.634315] NET: Registered protocol family 1 [ 0.636562] RPC: Registered named UNIX socket transport module. [ 0.638156] RPC: Registered udp transport module. [ 0.639153] RPC: Registered tcp transport module. [ 0.640393] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.641632] NET: Registered protocol family 44 [ 0.642655] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.643839] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.645495] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.647823] PCI: CLS 0 bytes, default 64 [ 0.649627] Unpacking initramfs... [ 2.063803] debug: unmapping init [mem 0xffff8f933cc64000-0xffff8f933ffcffff] [ 2.067656] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.070050] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.072821] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.534427] Initialise system trusted keyrings [ 2.535724] Key type blacklist registered [ 2.537199] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.546953] zbud: loaded [ 2.550686] *** VALIDATE nfs *** [ 2.551950] *** VALIDATE nfs4 *** [ 2.553582] pstore: using deflate compression [ 2.557584] Platform Keyring initialized [ 2.655832] NET: Registered protocol family 38 [ 2.657107] Key type asymmetric registered [ 2.658488] Asymmetric key parser 'x509' registered [ 2.660248] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.663287] io scheduler mq-deadline registered [ 2.668498] io scheduler kyber registered [ 2.670088] io scheduler bfq registered [ 2.672585] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.676532] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.680374] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.684437] ACPI: Power Button [PWRF] [ 2.690378] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.697908] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.713747] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.741962] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.771354] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.778846] Non-volatile memory driver v1.3 [ 2.780541] Linux agpgart interface v0.103 [ 2.822498] virtio_blk virtio1: [vda] 149976 512-byte logical blocks (76.8 MB/73.2 MiB) [ 2.825581] vda: detected capacity change from 0 to 76787712 [ 2.840110] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.843297] vdb: detected capacity change from 0 to 1073741824 [ 2.853347] libphy: Fixed MDIO Bus: probed [ 2.874075] usbcore: registered new interface driver usbserial_generic [ 2.877141] usbserial: USB Serial support registered for generic [ 2.880205] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.885579] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.887919] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.890822] mousedev: PS/2 mouse device common for all mice [ 2.892543] rtc_cmos 00:05: RTC can wake from S4 [ 2.894834] rtc_cmos 00:05: registered as rtc0 [ 2.896091] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.898678] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.900718] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.902884] intel_pstate: CPU model not supported [ 2.905982] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.910322] hid: raw HID events driver (C) Jiri Kosina [ 2.912341] usbcore: registered new interface driver usbhid [ 2.914360] usbhid: USB HID core driver [ 2.915602] drop_monitor: Initializing network drop monitor service [ 2.918163] Initializing XFRM netlink socket [ 2.919919] NET: Registered protocol family 10 [ 2.922747] Segment Routing with IPv6 [ 2.924112] NET: Registered protocol family 17 [ 2.926123] mpls_gso: MPLS GSO support [ 2.931559] RAS: Correctable Errors collector initialized. [ 2.933452] AVX version of gcm_enc/dec engaged. [ 2.935157] AES CTR mode by8 optimization enabled [ 3.015264] sched_clock: Marking stable (3015193150, 0)->(3894092213, -878899063) [ 3.019186] registered taskstats version 1 [ 3.021404] Loading compiled-in X.509 certificates [ 3.023686] zswap: loaded using pool lzo/zbud [ 3.052654] Key type big_key registered [ 3.064369] Key type encrypted registered [ 3.065953] ima: No TPM chip found, activating TPM-bypass! [ 3.068477] ima: Allocated hash algorithm: sha1 [ 3.070539] ima: No architecture policies found [ 3.072203] evm: Initialising EVM extended attributes: [ 3.073766] evm: security.selinux [ 3.075031] evm: security.ima [ 3.076162] evm: security.capability [ 3.077381] evm: HMAC attrs: 0x1 [ 3.080171] rtc_cmos 00:05: setting system clock to 2026-09-07 20:42:22 UTC (1788813742) [ 3.088753] debug: unmapping init [mem 0xffffffff93e03000-0xffffffff93ffffff] [ 3.092033] debug: unmapping init [mem 0xffffffff92b82000-0xffffffff92e58fff] [ 3.102071] Write protecting the kernel read-only data: 28672k [ 3.106322] debug: unmapping init [mem 0xffffffff91203000-0xffffffff913fffff] [ 3.109340] debug: unmapping init [mem 0xffffffff91b14000-0xffffffff91bfffff] [ 3.142879] 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.152569] systemd[1]: Detected virtualization kvm. [ 3.154669] systemd[1]: Detected architecture x86-64. [ 3.156626] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.183650] systemd[1]: No hostname configured. [ 3.185219] systemd[1]: Set hostname to . [ 3.187170] random: systemd: uninitialized urandom read (16 bytes read) [ 3.189835] systemd[1]: Initializing machine ID from random generator. [ 3.314338] random: systemd: uninitialized urandom read (16 bytes read) [ 3.317287] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.322043] random: systemd: uninitialized urandom read (16 bytes read) [ 3.323901] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 3.327623] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Paths. [ OK ] Reached target Timers. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Journal Service... Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Slices. Starting Setup Virtual Console... [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.845082] device-mapper: uevent: version 1.0.3 [ 3.847156] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.433429] virtio_net virtio0 ens2: renamed from eth0 [ 4.475718] scsi host0: ata_piix [ 4.481525] scsi host1: ata_piix [ 4.482683] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.484689] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.655729] dracut-initqueue[583]: RTNETLINK answers: File exists [ 9.582465] random: crng init done [ 9.583784] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 9.760707] 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. [ OK ] Stopped dracut pre-pivot and cleanup hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Sockets. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 10.960870] printk: systemd: 25 output lines suppressed due to ratelimiting [ 11.220378] SELinux: Disabled at runtime. [ 11.280442] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.289250] systemd[1]: Detected virtualization kvm. [ 11.291395] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.879334] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.883713] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.891512] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.896847] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.902541] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.918228] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.923322] systemd[1]: Listening on initctl Compatibility Named Pipe. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on udev Kernel Socket. [ OK ] Stopped target Switch Root. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Stopped target Initrd Root File System. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Mounting POSIX Message Queue File System... Activating swap /dev/disk/by-label/SWAP... Starting Apply Kernel Variables... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper[ 11.986284] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS . Mounting Huge Pages File System... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... Mounting Kernel Debug File System... [ OK ] Stopped target Initrd File Systems. [ OK ] Listening on Process Core Dump Socket. Starting Remount Root and Kernel File Systems... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-getty.slice. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 12.388412] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.725575] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.785661] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.972366] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.990303] EDAC sbridge: Ver: 1.1.2 [ 14.333192] Key type dns_resolver registered [ 14.634149] NFS: Registering the id_resolver key type [ 14.636142] Key type id_resolver registered [ 14.637746] 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 Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. [ OK ] Started D-Bus System Message Bus. Starting Restore /run/initramfs on shutdown... Starting Network Manager... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg128-client login: [ 43.189270] libcfs: loading out-of-tree module taints kernel. [ 43.240268] Key type ._llcrypt registered [ 43.242240] Key type .llcrypt registered [ 43.571507] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 43.578624] alg: No test for adler32 (adler32-zlib) [ 44.614416] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 44.979170] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 46.615218] Key type lgssc registered [ 47.309891] Lustre: Echo OBD driver; http://www.lustre.org/ [ 94.612888] hrtimer: interrupt took 2008768 ns [ 227.525623] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 232.415649] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 245.152231] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing check_logdir /tmp/testlogs/ [ 250.380684] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing yml_node [ 253.416607] Lustre: lustre-OST0000-osc-ffff8f9390b20800: disconnect after 23s idle [ 254.685418] Lustre: DEBUG MARKER: Client: 2.17.58.40 [ 257.599414] Lustre: DEBUG MARKER: MDS: 2.17.58.40 [ 260.041242] Lustre: DEBUG MARKER: OSS: 2.17.58.40 [ 261.460817] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon Sep 7 16:46:39 EDT 2026 [ 278.987349] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 280.437538] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 282.394510] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 292.703093] Lustre: Unmounted lustre-client [ 397.263774] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 402.480388] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 423.008354] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 456.942275] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 16:49:55 (1788814195) [ 459.204308] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 460.901705] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 16:49:58 (1788814198) [ 489.420579] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 495.227591] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 512.768696] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 513.226808] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 516.844162] Lustre: Unmounted lustre-client [ 541.990558] Key type lgssc unregistered [ 542.370971] LNet: 15024:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 542.388197] LNetError: 15024:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 542.401737] LNet: Removed LNI 192.168.201.28@tcp [ 543.392129] Key type .llcrypt unregistered [ 543.394408] Key type ._llcrypt unregistered [ 557.653381] Key type ._llcrypt registered [ 557.654593] Key type .llcrypt registered [ 558.804682] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 16:51:36 (1788814296) [ 559.984956] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 560.082658] alg: No test for adler32 (adler32-zlib) [ 561.100764] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 561.337269] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 563.009680] Key type lgssc registered [ 564.029620] Lustre: Echo OBD driver; http://www.lustre.org/ [ 626.274655] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 710.873699] Lustre: Unmounted lustre-client [ 740.619497] Key type lgssc unregistered [ 740.820264] LNet: 18801:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 740.824299] LNetError: 18801:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 740.832798] LNet: Removed LNI 192.168.201.28@tcp [ 741.533609] Key type .llcrypt unregistered [ 741.535736] Key type ._llcrypt unregistered [ 750.470802] Key type ._llcrypt registered [ 750.476447] Key type .llcrypt registered [ 751.639209] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 16:54:49 (1788814489) [ 753.634891] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 753.787480] alg: No test for adler32 (adler32-zlib) [ 754.907626] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 755.164842] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 756.831314] Key type lgssc registered [ 758.072594] Lustre: Echo OBD driver; http://www.lustre.org/ [ 799.605672] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 803.801204] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 820.683405] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 827.412919] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 835.581196] Lustre: Unmounted lustre-client [ 858.451102] Key type lgssc unregistered [ 858.615286] LNet: 22395:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 858.620679] LNetError: 22395:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 858.645316] LNet: Removed LNI 192.168.201.28@tcp [ 859.100978] Key type .llcrypt unregistered [ 859.103455] Key type ._llcrypt unregistered [ 867.344804] Key type ._llcrypt registered [ 867.346663] Key type .llcrypt registered [ 868.390108] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 16:56:46 (1788814606) [ 870.055538] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 870.122347] alg: No test for adler32 (adler32-zlib) [ 871.115260] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 871.292809] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 872.911327] Key type lgssc registered [ 873.797570] Lustre: Echo OBD driver; http://www.lustre.org/ [ 910.353802] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 914.665524] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 929.428887] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 941.597904] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 946.466238] Lustre: Unmounted lustre-client [ 971.661126] Key type lgssc unregistered [ 971.928575] LNet: 25582:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 971.935449] LNetError: 25582:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 971.948512] LNet: Removed LNI 192.168.201.28@tcp [ 972.537625] Key type .llcrypt unregistered [ 972.541093] Key type ._llcrypt unregistered [ 984.253976] Key type ._llcrypt registered [ 984.256857] Key type .llcrypt registered [ 985.234675] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 16:58:43 (1788814723) [ 986.962571] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 987.084558] alg: No test for adler32 (adler32-zlib) [ 988.089047] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 988.267503] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 989.967420] Key type lgssc registered [ 990.983270] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1028.587352] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1032.811852] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1049.194371] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1054.761294] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 1059.819820] Lustre: lustre-MDT0000-mdc-ffff8f9384ccc000: Connection to lustre-MDT0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1065.702966] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1076.020150] LustreError: MGC192.168.201.128@tcp: Connection to MGS (at 192.168.201.128@tcp) was lost; in progress operations using this service will fail [ 1076.046394] Lustre: Unmounted lustre-client [ 1102.068656] Key type lgssc unregistered [ 1102.252902] LNet: 29229:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1102.258164] LNetError: 29229:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1102.272247] LNet: Removed LNI 192.168.201.28@tcp [ 1102.791781] Key type .llcrypt unregistered [ 1102.795832] Key type ._llcrypt unregistered [ 1114.363774] Key type ._llcrypt registered [ 1114.365532] Key type .llcrypt registered [ 1115.351274] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 17:00:53 (1788814853) [ 1117.299262] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1117.322108] alg: No test for adler32 (adler32-zlib) [ 1118.421119] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 1118.644241] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 1120.312488] Key type lgssc registered [ 1121.458384] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1159.329674] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1163.183315] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1176.210993] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1187.338522] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 1192.430769] Lustre: lustre-OST0000-osc-ffff8f93a0344000: Connection to lustre-OST0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1198.527971] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1208.869368] Lustre: Unmounted lustre-client [ 1232.094400] Key type lgssc unregistered [ 1232.314605] LNet: 32849:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1232.325228] LNetError: 32849:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1233.388863] LNet: Removed LNI 192.168.201.28@tcp [ 1234.062465] Key type .llcrypt unregistered [ 1234.064754] Key type ._llcrypt unregistered [ 1246.132192] Key type ._llcrypt registered [ 1246.135582] Key type .llcrypt registered [ 1247.276223] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 17:03:05 (1788814985) [ 1249.158914] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1249.178162] alg: No test for adler32 (adler32-zlib) [ 1250.216403] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 1250.433137] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 1252.103603] Key type lgssc registered [ 1252.973538] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1290.209777] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1293.979225] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1308.289596] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1318.949071] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 1321.681957] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1324.468625] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1335.633724] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-0717h04m34s [ 1337.006200] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1339.372985] Lustre: lustre-MDT0000-mdc-ffff8f939000a000: Connection to lustre-MDT0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1346.194883] LustreError: 36631:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8f939000a000: can't stat MDS #0: rc = -19 [ 1347.361386] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1356.776075] LustreError: MGC192.168.201.128@tcp: Connection to MGS (at 192.168.201.128@tcp) was lost; in progress operations using this service will fail [ 1356.791674] Lustre: Evicted from MGS (at 192.168.201.128@tcp) after server handle changed from 0xc279647bd12db75d to 0xc279647bd12dbaf9 [ 1356.806392] Lustre: MGC192.168.201.128@tcp: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 1357.743257] Lustre: DEBUG MARKER: Wait for df (36631) ... [ 1357.876703] LustreError: lustre-MDT0000-mdc-ffff8f939000a000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1357.892806] Lustre: lustre-MDT0000-mdc-ffff8f939000a000: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 1358.672025] Lustre: DEBUG MARKER: done [ 1359.326798] Lustre: Unmounted lustre-client [ 1381.410826] Key type lgssc unregistered [ 1381.590093] LNet: 37642:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1381.601783] LNetError: 37642:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1381.629553] LNet: Removed LNI 192.168.201.28@tcp [ 1381.996846] Key type .llcrypt unregistered [ 1381.998826] Key type ._llcrypt unregistered [ 1401.383347] Key type ._llcrypt registered [ 1401.386539] Key type .llcrypt registered [ 1402.283899] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 17:05:40 (1788815140) [ 1404.083029] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1404.115885] alg: No test for adler32 (adler32-zlib) [ 1405.135729] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 1405.288118] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 1406.944601] Key type lgssc registered [ 1407.779340] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1442.782720] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1445.894784] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1459.201583] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1460.709373] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 1464.072152] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-0717h06m42s [ 1465.004952] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1469.660611] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1471.233089] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1491.423458] Lustre: 41777:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788815210/real 1788815210] req@0000000026a8e4c7 x1875708628441216/t0(0) o101->lustre-MDT0000-mdc-ffff8f93924e7800@192.168.201.128@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788815230 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1491.448137] Lustre: lustre-MDT0000-mdc-ffff8f93924e7800: Connection to lustre-MDT0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1491.483771] Lustre: lustre-MDT0000-mdc-ffff8f93924e7800: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 1512.651549] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1514.968026] Lustre: DEBUG MARKER: done [ 1517.778680] Lustre: Unmounted lustre-client [ 1539.679531] Key type lgssc unregistered [ 1539.862166] LNet: 42652:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1539.870116] LNetError: 42652:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1539.884917] LNet: Removed LNI 192.168.201.28@tcp [ 1540.319570] Key type .llcrypt unregistered [ 1540.321510] Key type ._llcrypt unregistered [ 1559.784129] Key type ._llcrypt registered [ 1559.785679] Key type .llcrypt registered [ 1560.602490] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 17:08:19 (1788815299) [ 1561.589542] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1562.580069] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 17:08:21 (1788815301) [ 1564.815167] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1564.851348] alg: No test for adler32 (adler32-zlib) [ 1565.827847] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 1565.983328] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 1567.623218] Key type lgssc registered [ 1568.296718] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1585.524984] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 17:08:44 (1788815324) [ 1605.832704] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1609.613418] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1622.176238] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1628.667643] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 1631.246672] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1633.041911] Lustre: Unmounted lustre-client [ 1645.263796] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1681.948870] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1685.114219] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1685.410527] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 1686.903931] Lustre: Unmounted lustre-client [ 1719.472181] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1722.586818] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1722.991790] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 1724.535704] Lustre: Unmounted lustre-client [ 1739.331660] Lustre: DEBUG MARKER: files compared the same [ 1756.564707] Key type lgssc unregistered [ 1756.727436] LNet: 50247:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1756.730864] LNetError: 50247:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1756.739751] LNet: Removed LNI 192.168.201.28@tcp [ 1757.144707] Key type .llcrypt unregistered [ 1757.146508] Key type ._llcrypt unregistered [ 1765.628122] Key type ._llcrypt registered [ 1765.629919] Key type .llcrypt registered [ 1766.384651] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 17:11:44 (1788815504) [ 1767.542044] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1767.631480] alg: No test for adler32 (adler32-zlib) [ 1768.567813] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 1768.723808] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 1770.343190] Key type lgssc registered [ 1770.983901] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1798.266230] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1801.099200] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1811.685948] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1814.076038] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 1820.001170] Lustre: Unmounted lustre-client [ 1829.129962] Key type lgssc unregistered [ 1829.285425] LNet: 53819:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1829.295244] LNetError: 53819:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1829.305899] LNet: Removed LNI 192.168.201.28@tcp [ 1829.642776] Key type .llcrypt unregistered [ 1829.644184] Key type ._llcrypt unregistered [ 1836.481324] Key type ._llcrypt registered [ 1836.482697] Key type .llcrypt registered [ 1837.104934] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 17:12:55 (1788815575) [ 1838.168689] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1838.186709] alg: No test for adler32 (adler32-zlib) [ 1839.099686] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 1839.210816] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 1840.816464] Key type lgssc registered [ 1841.423556] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1906.996313] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1922.823067] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1925.209724] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1945.309446] Key type lgssc unregistered [ 1945.479901] LNet: 57293:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1945.492656] LNetError: 57293:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1945.508946] LNet: Removed LNI 192.168.201.28@tcp [ 1945.914288] Key type .llcrypt unregistered [ 1945.915765] Key type ._llcrypt unregistered [ 1954.119107] Key type ._llcrypt registered [ 1954.121362] Key type .llcrypt registered [ 1954.818912] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 17:14:53 (1788815693) [ 1956.661407] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1956.692072] alg: No test for adler32 (adler32-zlib) [ 1957.689089] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 1957.866861] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 1959.511362] Key type lgssc registered [ 1960.254502] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1999.932020] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 2005.468159] Lustre: Unmounted lustre-client [ 2031.357860] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 17:16:10 (1788815770) [ 2096.882905] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2110.974589] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 2116.544445] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2116.546876] LustreError: 63747:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8f93880e3000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2116.556251] Lustre: 58274:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.201.128@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2126.850570] Lustre: Unmounted lustre-client [ 2157.794149] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 17:18:16 (1788815896) [ 2164.168833] Key type lgssc unregistered [ 2164.384664] LNet: 64954:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2164.388698] LNetError: 64954:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2164.408620] LNet: Removed LNI 192.168.201.28@tcp [ 2164.831098] Key type .llcrypt unregistered [ 2164.833095] Key type ._llcrypt unregistered [ 2170.980682] Key type ._llcrypt registered [ 2170.996575] Key type .llcrypt registered [ 2171.288501] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2171.296943] alg: No test for adler32 (adler32-zlib) [ 2172.243322] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 2172.400484] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 2174.007211] Key type lgssc registered [ 2174.630843] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2203.170807] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2205.861747] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2222.096903] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2225.195900] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 2231.242483] Lustre: Unmounted lustre-client [ 2270.569910] Key type lgssc unregistered [ 2271.227956] LNet: 67958:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2271.233220] LNetError: 67958:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2271.251961] LNet: Removed LNI 192.168.201.28@tcp [ 2273.068988] Key type .llcrypt unregistered [ 2273.088061] Key type ._llcrypt unregistered [ 2293.461627] Key type ._llcrypt registered [ 2293.463670] Key type .llcrypt registered [ 2294.228155] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2294.246561] alg: No test for adler32 (adler32-zlib) [ 2295.450221] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 2295.814225] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 2297.631265] Key type lgssc registered [ 2299.104737] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2412.069877] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2417.064655] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2435.579573] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2438.439973] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 2440.791917] Lustre: Unmounted lustre-client [ 2470.689926] Key type lgssc unregistered [ 2470.999283] LNet: 71393:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2471.005089] LNetError: 71393:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2471.031850] LNet: Removed LNI 192.168.201.28@tcp [ 2471.699565] Key type .llcrypt unregistered [ 2471.703332] Key type ._llcrypt unregistered [ 2486.694289] Key type ._llcrypt registered [ 2486.696704] Key type .llcrypt registered [ 2488.002412] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 17:23:45 (1788816225) [ 2490.130089] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2490.217282] alg: No test for adler32 (adler32-zlib) [ 2491.258605] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 2491.444434] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 2493.109686] Key type lgssc registered [ 2494.090445] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2539.610854] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2544.810554] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2564.531032] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2567.143261] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 2572.322615] Lustre: Unmounted lustre-client [ 2572.750802] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 2575.101610] Lustre: Unmounted lustre-client [ 2607.243969] Key type lgssc unregistered [ 2607.530825] LNet: 75074:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2607.535552] LNetError: 75074:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2607.549785] LNet: Removed LNI 192.168.201.28@tcp [ 2608.335515] Key type .llcrypt unregistered [ 2608.339846] Key type ._llcrypt unregistered [ 2622.522862] Key type ._llcrypt registered [ 2622.535227] Key type .llcrypt registered [ 2622.800898] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2622.817577] alg: No test for adler32 (adler32-zlib) [ 2623.865672] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 2624.063711] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 2625.679255] Key type lgssc registered [ 2626.965641] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2676.158479] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2681.890603] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2703.662188] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2705.314583] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 2713.017391] Lustre: Unmounted lustre-client [ 2739.578750] Key type lgssc unregistered [ 2739.852945] LNet: 78106:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2739.858507] LNetError: 78106:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2740.902604] LNet: Removed LNI 192.168.201.28@tcp [ 2741.777536] Key type .llcrypt unregistered [ 2741.780115] Key type ._llcrypt unregistered [ 2757.531626] Key type ._llcrypt registered [ 2757.533940] Key type .llcrypt registered [ 2758.912237] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 17:28:16 (1788816496) [ 2761.189178] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2761.355326] alg: No test for adler32 (adler32-zlib) [ 2762.511055] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 2762.824767] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 2764.497913] Key type lgssc registered [ 2765.855446] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2812.835717] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2817.911873] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2837.918898] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2840.764468] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 2847.743481] Lustre: lustre: root_squash is set to 0:0 [ 2857.494356] Lustre: lustre: nosquash_nids is cleared [ 2857.531293] Lustre: lustre: root_squash is set to 500:500 [ 2875.946447] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.201.28@tcp 192.168.0.[2,10]@tcp [ 2882.923498] Lustre: lustre: nosquash_nids set to 192.168.201.28/24@tcp [ 2889.695931] Lustre: Unmounted lustre-client [ 2913.287528] Key type lgssc unregistered [ 2913.485629] LNet: 82115:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2913.494258] LNetError: 82115:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2913.504492] LNet: Removed LNI 192.168.201.28@tcp [ 2914.060620] Key type .llcrypt unregistered [ 2914.063684] Key type ._llcrypt unregistered [ 2925.466415] Key type ._llcrypt registered [ 2925.468757] Key type .llcrypt registered [ 2926.679375] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 17:31:04 (1788816664) [ 2928.555572] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 2929.904230] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 17:31:08 (1788816668) [ 2931.782592] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2931.796268] alg: No test for adler32 (adler32-zlib) [ 2932.797952] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 2932.986023] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 2934.655240] Key type lgssc registered [ 2935.561591] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2971.365854] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2976.101409] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2991.903653] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2993.373669] Lustre: lustre: root_squash is set to 500:500 [ 2993.400830] Lustre: lustre: nosquash_nids set to 192.168.201.28/24@tcp [ 2998.848861] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 3003.365575] Lustre: Unmounted lustre-client [ 3026.963689] Key type lgssc unregistered [ 3027.187770] LNet: 86063:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3027.192818] LNetError: 86063:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3027.206356] LNet: Removed LNI 192.168.201.28@tcp [ 3027.663324] Key type .llcrypt unregistered [ 3027.665988] Key type ._llcrypt unregistered [ 3041.002961] Key type ._llcrypt registered [ 3041.005166] Key type .llcrypt registered [ 3042.316750] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3043.754425] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 17:33:01 (1788816781) [ 3059.402182] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3059.422160] alg: No test for adler32 (adler32-zlib) [ 3060.494976] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 3060.678389] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 3062.343261] Key type lgssc registered [ 3063.383154] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3128.055611] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3132.243640] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3150.308955] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3202.862375] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3206.666739] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3221.612728] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3236.690991] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 3258.865491] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8f938794b800.ost_server_uuid 50 [ 3259.774528] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8f938794b800.ost_server_uuid in FULL state after 0 sec [ 3260.096596] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 3262.940360] Lustre: Unmounted lustre-client [ 3264.276328] Lustre: Unmounted lustre-client [ 3300.508822] Key type lgssc unregistered [ 3300.712517] LNet: 93709:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3300.716880] LNetError: 93709:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3301.733951] LNet: Removed LNI 192.168.201.28@tcp [ 3302.174707] Key type .llcrypt unregistered [ 3302.176710] Key type ._llcrypt unregistered [ 3321.733341] Key type ._llcrypt registered [ 3321.735910] Key type .llcrypt registered [ 3322.468823] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 17:37:41 (1788817061) [ 3333.317754] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3333.394203] alg: No test for adler32 (adler32-zlib) [ 3334.370463] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 3334.527218] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 3336.168187] Key type lgssc registered [ 3336.862174] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3389.355642] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3392.654447] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3406.617933] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3408.050971] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 3425.135738] Lustre: lustre-OST0000-osc-ffff8f9385def800: Connection to lustre-OST0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3428.831238] Lustre: 95065:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788817152/real 1788817152] req@000000007a453efe x1875710651143296/t0(0) o400->lustre-OST0000-osc-ffff8f9385def800@192.168.201.128@tcp:28/4 lens 224/224 e 0 to 1 dl 1788817168 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3429.547115] Lustre: lustre-OST0000-osc-ffff8f9385def800: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 3430.887605] Lustre: lustre-MDT0000-mdc-ffff8f9385def800: Connection to lustre-MDT0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3434.975177] Lustre: 95065:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788817158/real 1788817158] req@000000003664f643 x1875710651143808/t0(0) o400->lustre-OST0000-osc-ffff8f9385def800@192.168.201.128@tcp:28/4 lens 224/224 e 0 to 1 dl 1788817174 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3440.031159] Lustre: 95066:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788817163/real 1788817163] req@00000000b37898ee x1875710651144320/t0(0) o400->lustre-OST0000-osc-ffff8f9385def800@192.168.201.128@tcp:28/4 lens 224/224 e 0 to 1 dl 1788817179 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3447.135210] Lustre: 95068:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788817170/real 1788817170] req@00000000116aa98c x1875710651145728/t0(0) o400->MGC192.168.201.128@tcp@192.168.201.128@tcp:26/25 lens 224/224 e 0 to 1 dl 1788817186 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3447.148434] LustreError: MGC192.168.201.128@tcp: Connection to MGS (at 192.168.201.128@tcp) was lost; in progress operations using this service will fail [ 3447.163181] Lustre: Evicted from MGS (at 192.168.201.128@tcp) after server handle changed from 0x52d69fdcc4aab2f9 to 0x52d69fdcc4aab5bc [ 3447.170317] Lustre: MGC192.168.201.128@tcp: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 3450.542654] Lustre: lustre-MDT0000-mdc-ffff8f9385def800: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 3451.799121] Lustre: Unmounted lustre-client [ 3472.775301] Key type lgssc unregistered [ 3472.944715] LNet: 99348:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3472.948807] LNetError: 99348:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3472.967222] LNet: Removed LNI 192.168.201.28@tcp [ 3473.397397] Key type .llcrypt unregistered [ 3473.399775] Key type ._llcrypt unregistered [ 3482.018291] Key type ._llcrypt registered [ 3482.020166] Key type .llcrypt registered [ 3482.754643] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 17:40:21 (1788817221) [ 3495.357624] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3495.381352] alg: No test for adler32 (adler32-zlib) [ 3496.297933] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 3496.421654] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 3498.028164] Key type lgssc registered [ 3498.627941] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3521.378145] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3573.952479] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3576.483617] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3590.769977] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3592.607861] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 3597.182564] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 3599.089253] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 17:42:17 (1788817337) [ 3806.155524] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3816.471575] Lustre: Unmounted lustre-client [ 3929.434660] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3934.683299] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3956.664469] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4013.329295] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 17:49:11 (1788817751) [ 4103.609555] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4109.578791] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4130.767747] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4131.375781] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 4136.091970] Lustre: Unmounted lustre-client [ 4170.688874] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 17:51:48 (1788817908) [ 4271.717710] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4277.382705] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4299.369720] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4299.938515] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 4304.504647] Lustre: Unmounted lustre-client [ 4340.543152] Key type lgssc unregistered [ 4340.753612] LNet: 122336:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4340.758593] LNetError: 122336:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4340.779944] LNet: Removed LNI 192.168.201.28@tcp [ 4341.427603] Key type .llcrypt unregistered [ 4341.429934] Key type ._llcrypt unregistered [ 4356.513623] Key type ._llcrypt registered [ 4356.515546] Key type .llcrypt registered [ 4357.697848] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 17:54:55 (1788818095) [ 4360.134282] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4360.220577] alg: No test for adler32 (adler32-zlib) [ 4361.415842] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 4361.731490] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 4363.463308] Key type lgssc registered [ 4364.772675] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4413.910466] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4420.442449] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4442.541245] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4444.546973] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 4462.467940] Lustre: Unmounted lustre-client [ 4490.749531] Key type lgssc unregistered [ 4491.012236] LNet: 125926:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4491.022957] LNetError: 125926:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4491.044755] LNet: Removed LNI 192.168.201.28@tcp [ 4491.855268] Key type .llcrypt unregistered [ 4491.860761] Key type ._llcrypt unregistered [ 4509.303808] Key type ._llcrypt registered [ 4509.309267] Key type .llcrypt registered [ 4510.858985] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 17:57:28 (1788818248) [ 4513.078079] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4513.219080] alg: No test for adler32 (adler32-zlib) [ 4514.397859] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 4514.688917] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 4516.359238] Key type lgssc registered [ 4517.630520] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4572.130421] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4577.423641] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4601.669543] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4603.381324] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 4613.622086] Lustre: lustre-OST0000-osc-ffff8f9390031000: Connection to lustre-OST0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4626.188448] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8f9390031000.ost_server_uuid 50 [ 4627.764957] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 4639.351661] Lustre: Unmounted lustre-client [ 4661.337882] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 17:59:59 (1788818399) [ 4695.234187] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4700.780316] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4724.734384] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4752.915817] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4753.630751] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 4759.024447] Lustre: lustre-OST0000-osc-ffff8f9390009000: Connection to lustre-OST0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4788.577757] Lustre: Unmounted lustre-client [ 4836.036293] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 18:02:54 (1788818574) [ 4871.188415] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4875.815759] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4897.190796] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4921.851269] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4922.512509] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 4927.983550] Lustre: lustre-OST0000-osc-ffff8f9386a73000: Connection to lustre-OST0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4944.739307] Lustre: Unmounted lustre-client [ 4992.057843] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 18:05:30 (1788818730) [ 5088.391047] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5093.918836] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5118.632154] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5191.845987] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5197.124857] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5216.582195] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5247.270412] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 5288.647445] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5294.234762] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 4 sec [ 5295.069300] Lustre: Unmounted lustre-client [ 5336.778252] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 18:11:14 (1788819074) [ 5369.795762] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5374.631473] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5393.566837] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5425.733607] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5453.996897] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 5497.180283] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5498.645317] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5500.403405] Lustre: lustre-OST0001-osc-ffff8f9384724800: Connection to lustre-OST0001 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5511.385222] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5521.736240] Lustre: Unmounted lustre-client [ 5588.424660] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 18:15:26 (1788819326) [ 5626.275276] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5632.638869] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5658.201763] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5658.669642] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 5682.428135] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5685.194018] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5706.360168] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8f9391ce6000.ost_server_uuid 50 [ 5708.785153] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8f9391ce6000.ost_server_uuid in IDLE state after 0 sec [ 5712.890565] Lustre: Unmounted lustre-client [ 5713.413498] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 5713.434469] Lustre: Skipped 3 previous similar messages [ 5713.837842] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 5715.566587] LustreError: 149367:0:(sec.c:409:import_sec_validate_get()) import 0000000098337fc2 (NEW) with no sec [ 5795.360837] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 18:18:53 (1788819533) [ 5836.455133] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5842.988162] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5866.721181] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5888.714945] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5889.399228] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5889.602519] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 5904.320200] Lustre: Unmounted lustre-client [ 5904.322345] Lustre: Skipped 1 previous similar message [ 5941.432396] Key type lgssc unregistered [ 5941.689217] LNet: 152792:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5941.717665] LNetError: 152792:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5941.776545] LNet: Removed LNI 192.168.201.28@tcp [ 5942.810092] Key type .llcrypt unregistered [ 5942.812496] Key type ._llcrypt unregistered [ 5962.796793] Key type ._llcrypt registered [ 5962.803655] Key type .llcrypt registered [ 5964.658242] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 18:21:41 (1788819701) [ 5965.884191] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5966.129569] alg: No test for adler32 (adler32-zlib) [ 5967.411213] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 5967.693901] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 5969.409406] Key type lgssc registered [ 5971.477402] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6021.607343] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6027.115539] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6052.456313] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6076.026463] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6077.555633] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6078.740298] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 6086.195418] LustreError: lustre-MDT0001-mdc-ffff8f93924e7800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6086.230637] Lustre: lustre-MDT0001-mdc-ffff8f93924e7800: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 6093.435546] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6095.391318] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6119.935087] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6124.167497] Lustre: Unmounted lustre-client [ 6155.034590] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 18:24:52 (1788819892) [ 6262.537342] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6269.719726] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6294.831370] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6295.511882] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 6322.465528] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6324.194869] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6336.554180] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6346.975132] Lustre: Unmounted lustre-client [ 6381.082871] Key type lgssc unregistered [ 6381.362551] LNet: 162412:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6381.380597] LNetError: 162412:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6381.415167] LNet: Removed LNI 192.168.201.28@tcp [ 6382.225386] Key type .llcrypt unregistered [ 6382.228875] Key type ._llcrypt unregistered [ 6418.675913] Key type ._llcrypt registered [ 6418.679322] Key type .llcrypt registered [ 6420.778315] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 18:29:17 (1788820157) [ 6423.388265] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6423.415959] alg: No test for adler32 (adler32-zlib) [ 6424.703205] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 6425.145670] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 6427.040832] Key type lgssc registered [ 6428.222071] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6485.311745] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6491.229815] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6517.779881] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6520.503283] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 6568.270967] Lustre: Unmounted lustre-client [ 6609.216884] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6609.926409] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 6645.533772] Lustre: Unmounted lustre-client [ 6681.650380] Key type lgssc unregistered [ 6681.928155] LNet: 166863:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6681.932321] LNetError: 166863:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6681.949384] LNet: Removed LNI 192.168.201.28@tcp [ 6682.667356] Key type .llcrypt unregistered [ 6682.669255] Key type ._llcrypt unregistered [ 6698.868715] Key type ._llcrypt registered [ 6698.875202] Key type .llcrypt registered [ 6700.357909] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 18:33:58 (1788820438) [ 6702.696043] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6702.706770] alg: No test for adler32 (adler32-zlib) [ 6703.852357] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 6704.134504] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 6705.864308] Key type lgssc registered [ 6707.086677] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6758.702970] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6765.522802] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6789.941039] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6793.147320] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 6813.147726] Lustre: Unmounted lustre-client [ 6841.719913] Key type lgssc unregistered [ 6842.031896] LNet: 170619:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6842.045427] LNetError: 170619:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6842.061526] LNet: Removed LNI 192.168.201.28@tcp [ 6842.838394] Key type .llcrypt unregistered [ 6842.840944] Key type ._llcrypt unregistered [ 6858.185820] Key type ._llcrypt registered [ 6858.190032] Key type .llcrypt registered [ 6858.848394] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6858.948589] alg: No test for adler32 (adler32-zlib) [ 6859.885693] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 6860.092524] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 6861.743717] Key type lgssc registered [ 6862.842775] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6919.632275] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6926.700954] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6950.024282] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6951.783995] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 6959.097036] Lustre: Unmounted lustre-client [ 6991.934803] Key type lgssc unregistered [ 6992.171769] LNet: 173679:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6992.180368] LNetError: 173679:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6992.194482] LNet: Removed LNI 192.168.201.28@tcp [ 6993.088636] Key type .llcrypt unregistered [ 6993.091995] Key type ._llcrypt unregistered [ 7008.435431] Key type ._llcrypt registered [ 7008.436538] Key type .llcrypt registered [ 7009.920177] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 18:39:07 (1788820747) [ 7011.931437] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7011.949327] alg: No test for adler32 (adler32-zlib) [ 7013.069487] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 7013.365506] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 7015.095484] Key type lgssc registered [ 7016.217469] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7062.032293] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7068.028687] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7087.431663] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7089.303050] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 7112.734738] Lustre: Unmounted lustre-client [ 7150.210517] Key type lgssc unregistered [ 7150.481835] LNet: 177432:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7150.495017] LNetError: 177432:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7150.520049] LNet: Removed LNI 192.168.201.28@tcp [ 7151.266377] Key type .llcrypt unregistered [ 7151.272579] Key type ._llcrypt unregistered [ 7164.862871] Key type ._llcrypt registered [ 7164.869462] Key type .llcrypt registered [ 7165.339935] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7165.377869] alg: No test for adler32 (adler32-zlib) [ 7166.584113] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 7166.932529] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 7168.687346] Key type lgssc registered [ 7170.173412] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7223.548624] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7230.160771] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7250.431880] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7251.993730] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 7269.579216] Lustre: Unmounted lustre-client [ 7294.002925] Key type lgssc unregistered [ 7294.505341] LNet: 180496:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7294.523392] LNetError: 180496:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7294.551882] LNet: Removed LNI 192.168.201.28@tcp [ 7295.558901] Key type .llcrypt unregistered [ 7295.559859] Key type ._llcrypt unregistered [ 7312.806409] Key type ._llcrypt registered [ 7312.807517] Key type .llcrypt registered [ 7314.694677] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 18:44:12 (1788821052) [ 7340.679540] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7340.697251] alg: No test for adler32 (adler32-zlib) [ 7341.647873] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 7341.820888] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 7343.471414] Key type lgssc registered [ 7344.850277] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7437.601921] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7443.902780] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7465.145684] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7504.632265] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 18:47:23 (1788821243) [ 7533.858168] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7539.466378] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7561.905408] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7564.912887] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 7573.170179] Lustre: Unmounted lustre-client [ 7602.669485] Key type lgssc unregistered [ 7602.881069] LNet: 187593:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7602.887528] LNetError: 187593:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7602.903475] LNet: Removed LNI 192.168.201.28@tcp [ 7603.596550] Key type .llcrypt unregistered [ 7603.597970] Key type ._llcrypt unregistered [ 7616.333989] Key type ._llcrypt registered [ 7616.335774] Key type .llcrypt registered [ 7617.131287] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 7619.313268] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 18:49:17 (1788821357) [ 7641.586088] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7641.633486] alg: No test for adler32 (adler32-zlib) [ 7642.777795] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 7643.171967] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 7644.911314] Key type lgssc registered [ 7646.272929] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7742.045755] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7747.374253] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7770.149500] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7792.973972] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7794.690258] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 7819.897386] Lustre: Unmounted lustre-client [ 7958.509894] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7964.173315] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7986.422155] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8034.730690] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 18:56:12 (1788821772) [ 8036.208890] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8038.610927] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 18:56:15 (1788821775) [ 8130.474212] Key type lgssc unregistered [ 8130.733832] LNet: 199024:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8130.742497] LNetError: 199024:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8130.762798] LNet: Removed LNI 192.168.201.28@tcp [ 8131.479366] Key type .llcrypt unregistered [ 8131.481158] Key type ._llcrypt unregistered [ 8151.037989] Key type ._llcrypt registered [ 8151.044205] Key type .llcrypt registered [ 8152.523909] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 18:58:10 (1788821890) [ 8193.197440] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8193.311216] alg: No test for adler32 (adler32-zlib) [ 8194.420419] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 8194.575338] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 8196.266405] Key type lgssc registered [ 8197.573923] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8245.762748] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8253.958137] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8293.934620] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8325.347603] Key type lgssc unregistered [ 8325.717796] LNet: 202765:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8325.727078] LNetError: 202765:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8325.755982] LNet: Removed LNI 192.168.201.28@tcp [ 8326.675835] Key type .llcrypt unregistered [ 8326.677133] Key type ._llcrypt unregistered [ 8343.183324] Key type ._llcrypt registered [ 8343.187315] Key type .llcrypt registered [ 8344.349608] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 19:01:22 (1788822082) [ 8347.022390] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8347.141026] alg: No test for adler32 (adler32-zlib) [ 8348.290382] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 8348.500681] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 8350.169899] Key type lgssc registered [ 8351.295509] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8399.760694] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8405.900775] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8431.064575] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8433.653802] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 8448.994470] Lustre: lustre-MDT0000-mdc-ffff8f93a0347800: Connection to lustre-MDT0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8454.129145] Lustre: lustre-MDT0001-mdc-ffff8f93a0347800: Connection to lustre-MDT0001 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8470.306372] Lustre: 203752:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788822193/real 1788822193] req@00000000cb833082 x1875715908780800/t0(0) o400->MGC192.168.201.128@tcp@192.168.201.128@tcp:26/25 lens 224/224 e 0 to 1 dl 1788822209 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 8470.349067] LustreError: MGC192.168.201.128@tcp: Connection to MGS (at 192.168.201.128@tcp) was lost; in progress operations using this service will fail [ 8479.599144] Lustre: Evicted from MGS (at 192.168.201.128@tcp) after server handle changed from 0xb75644781453a7fa to 0xb75644781453c3fa [ 8479.609367] Lustre: MGC192.168.201.128@tcp: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 8499.197432] LustreError: lustre-MDT0000-mdc-ffff8f93a0347800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 8499.289701] Lustre: lustre-MDT0000-mdc-ffff8f93a0347800: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 8505.280537] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8506.582545] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8511.733219] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8513.038256] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8515.134450] Lustre: Unmounted lustre-client [ 8544.204476] Key type lgssc unregistered [ 8544.428742] LNet: 207704:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8544.432101] LNetError: 207704:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8544.450657] LNet: Removed LNI 192.168.201.28@tcp [ 8545.141145] Key type .llcrypt unregistered [ 8545.148348] Key type ._llcrypt unregistered [ 8560.410502] Key type ._llcrypt registered [ 8560.412909] Key type .llcrypt registered [ 8561.543520] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 19:04:59 (1788822299) [ 8563.082922] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8563.096888] alg: No test for adler32 (adler32-zlib) [ 8564.069762] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 8564.236107] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 8566.007244] Key type lgssc registered [ 8567.374046] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8609.649791] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8614.005849] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8669.451984] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8674.772513] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8708.690259] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8729.898083] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8778.460076] Key type lgssc unregistered [ 8778.774463] LNet: 212991:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8778.790555] LNetError: 212991:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8778.821636] LNet: Removed LNI 192.168.201.28@tcp [ 8779.799779] Key type .llcrypt unregistered [ 8779.801172] Key type ._llcrypt unregistered [ 8827.334549] Key type ._llcrypt registered [ 8827.337913] Key type .llcrypt registered [ 8828.824774] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 19:09:26 (1788822566) [ 8863.476549] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8863.527530] alg: No test for adler32 (adler32-zlib) [ 8864.688849] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 8864.998490] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 8866.695934] Key type lgssc registered [ 8868.492788] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8963.544421] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8969.395882] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8990.567158] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9032.492721] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 19:12:50 (1788822770) [ 9041.330847] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 19:12:58 (1788822778) [ 9077.711663] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9082.904922] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9103.192544] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9104.796106] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 9110.084409] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9111.880345] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9113.217535] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9114.555793] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9120.247977] Lustre: lustre-MDT0000-mdc-ffff8f939227d800: Connection to lustre-MDT0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9135.583270] Lustre: 214885:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788822859/real 1788822859] req@00000000b428d144 x1875716450821760/t0(0) o400->MGC192.168.201.128@tcp@192.168.201.128@tcp:26/25 lens 224/224 e 0 to 1 dl 1788822875 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9135.597715] LustreError: MGC192.168.201.128@tcp: Connection to MGS (at 192.168.201.128@tcp) was lost; in progress operations using this service will fail [ 9135.623636] Lustre: Evicted from MGS (at 192.168.201.128@tcp) after server handle changed from 0x1ec387b026aba640 to 0x1ec387b026aba7b3 [ 9135.635863] Lustre: MGC192.168.201.128@tcp: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 9150.686240] Lustre: lustre-MDT0000-mdc-ffff8f939227d800: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 9158.455652] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9159.923844] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9163.257889] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9165.801118] Lustre: lustre-MDT0000-mdc-ffff8f939227d800: Connection to lustre-MDT0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9182.175759] Lustre: 214885:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788822905/real 1788822905] req@00000000f149c901 x1875716450830208/t0(0) o400->MGC192.168.201.128@tcp@192.168.201.128@tcp:26/25 lens 224/224 e 0 to 1 dl 1788822921 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9182.208618] LustreError: MGC192.168.201.128@tcp: Connection to MGS (at 192.168.201.128@tcp) was lost; in progress operations using this service will fail [ 9192.432028] Lustre: Evicted from MGS (at 192.168.201.128@tcp) after server handle changed from 0x1ec387b026aba7b3 to 0x1ec387b026ababbf [ 9192.447933] Lustre: MGC192.168.201.128@tcp: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 9197.296545] Lustre: lustre-MDT0000-mdc-ffff8f939227d800: Connection restored to 192.168.201.128@tcp (at 192.168.201.128@tcp) [ 9204.836753] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9206.506671] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9209.580840] Lustre: Unmounted lustre-client [ 9277.589456] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9284.964641] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9303.985910] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9304.732766] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 9318.496255] Lustre: Unmounted lustre-client [ 9346.170374] Key type lgssc unregistered [ 9346.623745] LNet: 225470:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9346.631365] LNetError: 225470:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9346.652632] LNet: Removed LNI 192.168.201.28@tcp [ 9347.428511] Key type .llcrypt unregistered [ 9347.431136] Key type ._llcrypt unregistered [ 9365.554311] Key type ._llcrypt registered [ 9365.559344] Key type .llcrypt registered [ 9367.219483] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 19:18:24 (1788823104) [ 9371.494162] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9371.506525] alg: No test for adler32 (adler32-zlib) [ 9372.578748] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 9372.739897] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 9374.399336] Key type lgssc registered [ 9376.094439] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9437.679427] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9442.655207] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9468.410810] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9471.287286] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 9477.378376] Lustre: Unmounted lustre-client [ 9543.654221] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9549.199161] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9576.698242] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9577.357740] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 9585.504799] Lustre: Unmounted lustre-client [ 9667.024445] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9673.608100] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9698.962466] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9704.993563] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [ 9707.633885] Lustre: Unmounted lustre-client [ 9730.726178] Key type lgssc unregistered [ 9731.018943] LNet: 232527:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9731.036179] LNetError: 232527:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9732.084803] LNet: Removed LNI 192.168.201.28@tcp [ 9732.812844] Key type .llcrypt unregistered [ 9732.814507] Key type ._llcrypt unregistered [ 9752.236760] Key type ._llcrypt registered [ 9752.244973] Key type .llcrypt registered [ 9753.774061] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 19:24:51 (1788823491) [ 9756.848722] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9756.883728] alg: No test for adler32 (adler32-zlib) [ 9757.932983] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 9758.218826] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 9759.887379] Key type lgssc registered [ 9761.496224] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9811.918221] Key type lgssc unregistered [ 9812.342576] LNet: 234850:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9812.355740] LNetError: 234850:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9812.382728] LNet: Removed LNI 192.168.201.28@tcp [ 9813.534685] Key type .llcrypt unregistered [ 9813.536392] Key type ._llcrypt unregistered [ 9844.921575] Key type ._llcrypt registered [ 9844.923438] Key type .llcrypt registered [ 9845.399985] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9845.421513] alg: No test for adler32 (adler32-zlib) [ 9846.544487] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [ 9846.744423] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [ 9848.439544] Key type lgssc registered [ 9849.951943] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9934.047867] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9939.657550] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9961.119062] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10003.935765] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10005.884895] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 19:29:03 (1788823743) [10035.471621] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10042.200529] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10060.687172] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10081.649461] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10084.363782] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [10089.461560] Lustre: lustre-OST0001-osc-ffff8f9398bac800: Connection to lustre-OST0001 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [10095.823456] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10106.161113] Lustre: Unmounted lustre-client [10151.240919] Key type lgssc unregistered [10151.553093] LNet: 241964:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10151.565669] LNetError: 241964:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10151.579986] LNet: Removed LNI 192.168.201.28@tcp [10152.445863] Key type .llcrypt unregistered [10152.449992] Key type ._llcrypt unregistered [10183.863201] Key type ._llcrypt registered [10183.866581] Key type .llcrypt registered [10185.396909] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 19:32:03 (1788823923) [10199.872268] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10199.883351] alg: No test for adler32 (adler32-zlib) [10200.992758] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [10201.215445] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [10202.871241] Key type lgssc registered [10204.387851] Lustre: Echo OBD driver; http://www.lustre.org/ [10260.804690] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10265.526297] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10286.255826] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 19:33:44 (1788824024) [10320.721124] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10326.861065] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10346.822591] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10348.388986] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [10355.067114] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [10367.225739] Lustre: Unmounted lustre-client [10476.528416] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10482.137531] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10539.894839] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10540.551981] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [10542.944392] Lustre: Unmounted lustre-client [10566.171876] Key type lgssc unregistered [10566.480603] LNet: 249678:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10566.484435] LNetError: 249678:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10566.495284] LNet: Removed LNI 192.168.201.28@tcp [10567.052062] Key type .llcrypt unregistered [10567.054596] Key type ._llcrypt unregistered [10598.254946] Key type ._llcrypt registered [10598.266667] Key type .llcrypt registered [10598.851923] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10598.865585] alg: No test for adler32 (adler32-zlib) [10599.925428] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [10600.175030] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [10601.839252] Key type lgssc registered [10603.032617] Lustre: Echo OBD driver; http://www.lustre.org/ [10687.642457] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10692.890689] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10716.902925] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10758.838784] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [10760.356774] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 19:41:38 (1788824498) [10793.755586] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10799.071447] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10818.949645] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10824.206348] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [10826.569634] Lustre: Unmounted lustre-client [10855.222790] Key type lgssc unregistered [10855.446394] LNet: 256306:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10855.455598] LNetError: 256306:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10855.473815] LNet: Removed LNI 192.168.201.28@tcp [10856.342139] Key type .llcrypt unregistered [10856.352182] Key type ._llcrypt unregistered [10874.793641] Key type ._llcrypt registered [10874.796544] Key type .llcrypt registered [10876.229202] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [10877.828682] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 19:43:35 (1788824615) [10888.133673] Key type .llcrypt unregistered [10888.135947] Key type ._llcrypt unregistered [10897.823610] Key type ._llcrypt registered [10897.853581] Key type .llcrypt registered [10898.523227] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10898.532343] alg: No test for adler32 (adler32-zlib) [10899.626467] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [10899.850866] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [10901.535491] Key type lgssc registered [10902.962657] Lustre: Echo OBD driver; http://www.lustre.org/ [10958.228792] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10972.831175] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [10975.140391] Lustre: Unmounted lustre-client [11011.149630] Key type lgssc unregistered [11011.501734] LNet: 259753:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11011.507066] LNetError: 259753:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11011.557295] LNet: Removed LNI 192.168.201.28@tcp [11012.412804] Key type .llcrypt unregistered [11012.417092] Key type ._llcrypt unregistered [11029.423740] Key type ._llcrypt registered [11029.425264] Key type .llcrypt registered [11031.198593] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 19:46:08 (1788824768) [11033.655342] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11033.844231] alg: No test for adler32 (adler32-zlib) [11035.063320] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [11035.434963] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [11037.192829] Key type lgssc registered [11038.708813] Lustre: Echo OBD driver; http://www.lustre.org/ [11125.254114] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11157.367853] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11163.254686] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11165.951507] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [11168.273796] Lustre: Unmounted lustre-client [11194.654373] Key type lgssc unregistered [11194.916844] LNet: 263288:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11194.927432] LNetError: 263288:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11194.950442] LNet: Removed LNI 192.168.201.28@tcp [11195.641559] Key type .llcrypt unregistered [11195.650981] Key type ._llcrypt unregistered [11213.467272] Key type ._llcrypt registered [11213.469149] Key type .llcrypt registered [11214.693557] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 19:49:12 (1788824952) [11216.871884] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11216.999750] alg: No test for adler32 (adler32-zlib) [11218.116565] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [11218.350192] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [11220.103227] Key type lgssc registered [11221.272214] Lustre: Echo OBD driver; http://www.lustre.org/ [11272.499665] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11279.329259] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11301.641259] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11303.461517] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [11308.528166] Lustre: lustre-MDT0000-mdc-ffff8f939000e000: Connection to lustre-MDT0000 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [11313.827971] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11313.856433] LustreError: 266440:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [11314.177302] LustreError: MGC192.168.201.128@tcp: Connection to MGS (at 192.168.201.128@tcp) was lost; in progress operations using this service will fail [11314.224676] Lustre: Unmounted lustre-client [11333.694526] Key type lgssc unregistered [11333.904249] LNet: 266854:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11333.923251] LNetError: 266854:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11333.932592] LNet: Removed LNI 192.168.201.28@tcp [11334.523366] Key type .llcrypt unregistered [11334.528967] Key type ._llcrypt unregistered [11350.187295] Key type ._llcrypt registered [11350.189488] Key type .llcrypt registered [11351.376647] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 19:51:29 (1788825089) [11353.726867] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11353.937210] alg: No test for adler32 (adler32-zlib) [11355.029650] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [11355.330336] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [11357.071237] Key type lgssc registered [11358.370588] Lustre: Echo OBD driver; http://www.lustre.org/ [11405.376538] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11410.910110] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11430.393407] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11432.968218] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [11438.055851] Lustre: lustre-MDT0001-mdc-ffff8f9384721800: Connection to lustre-MDT0001 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [11443.476411] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [11445.306049] Lustre: Unmounted lustre-client [11464.916934] Key type lgssc unregistered [11465.206176] LNet: 270425:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11465.213600] LNetError: 270425:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11466.285303] LNet: Removed LNI 192.168.201.28@tcp [11467.133592] Key type .llcrypt unregistered [11467.136252] Key type ._llcrypt unregistered [11481.175221] Key type ._llcrypt registered [11481.176951] Key type .llcrypt registered [11482.377522] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 19:53:40 (1788825220) [11500.066724] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11500.083154] alg: No test for adler32 (adler32-zlib) [11501.169148] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [11501.447873] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [11503.151673] Key type lgssc registered [11504.351526] Lustre: Echo OBD driver; http://www.lustre.org/ [11601.759209] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11603.423511] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [11644.395737] Lustre: lustre-MDT0001-mdc-ffff8f938694c000: Connection to lustre-MDT0001 (at 192.168.201.128@tcp) was lost; in progress operations using this service will wait for recovery to complete [11654.280165] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11664.615325] Lustre: Unmounted lustre-client [11699.295981] Key type lgssc unregistered [11699.520970] LNet: 276203:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11699.525301] LNetError: 276203:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11699.535142] LNet: Removed LNI 192.168.201.28@tcp [11700.257751] Key type .llcrypt unregistered [11700.264636] Key type ._llcrypt unregistered [11716.473718] Key type ._llcrypt registered [11716.474942] Key type .llcrypt registered [11717.714197] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 19:57:35 (1788825455) [11719.250029] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [11720.752784] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 19:57:38 (1788825458) [11722.206509] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [11723.690731] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 19:57:41 (1788825461) [11725.186447] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [11726.589560] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 19:57:44 (1788825464) [11728.056814] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [11729.614285] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 19:57:47 (1788825467) [11731.192985] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [11732.725523] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 19:57:50 (1788825470) [11740.305313] Key type .llcrypt unregistered [11740.306468] Key type ._llcrypt unregistered [11747.338857] Key type ._llcrypt registered [11747.347786] Key type .llcrypt registered [11747.771978] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11747.794547] alg: No test for adler32 (adler32-zlib) [11748.950493] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [11749.214623] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [11750.935385] Key type lgssc registered [11752.258569] Lustre: Echo OBD driver; http://www.lustre.org/ [11819.860236] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11824.131741] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11844.271358] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11845.848781] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [11847.757178] Lustre: Unmounted lustre-client [11881.358957] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 20:00:19 (1788825619) [11913.900293] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11919.473971] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11950.913811] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11961.904875] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [11963.479147] Lustre: Unmounted lustre-client [12001.899296] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 20:02:20 (1788825740) [12013.407370] LNet: 1 local NIs in recovery (showing 1): 192.168.201.28@tcp [12638.070973] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12643.820735] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12679.910980] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12778.011746] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 20:15:15 (1788826515) [12788.924446] Key type lgssc unregistered [12789.202498] LNet: 289719:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12789.212253] LNetError: 289719:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12790.249533] LNet: Removed LNI 192.168.201.28@tcp [12791.049879] Key type .llcrypt unregistered [12791.055929] Key type ._llcrypt unregistered [12931.062985] Key type ._llcrypt registered [12931.068731] Key type .llcrypt registered [12931.553230] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12931.563899] alg: No test for adler32 (adler32-zlib) [12932.604324] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [12932.805491] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [12934.463246] Key type lgssc registered [12935.521637] Lustre: Echo OBD driver; http://www.lustre.org/ [13006.038343] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13009.954968] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13027.494426] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13054.180593] Key type lgssc unregistered [13054.378541] LNet: 293408:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13054.381580] LNetError: 293408:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13054.406551] LNet: Removed LNI 192.168.201.28@tcp [13054.824751] Key type .llcrypt unregistered [13054.826451] Key type ._llcrypt unregistered [13087.892583] Key type ._llcrypt registered [13087.895211] Key type .llcrypt registered [13088.877897] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 20:20:27 (1788826827) [13104.366395] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13104.385400] alg: No test for adler32 (adler32-zlib) [13105.285550] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [13105.413129] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [13107.047211] Key type lgssc registered [13107.834985] Lustre: Echo OBD driver; http://www.lustre.org/ [13145.085164] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 20:21:23 (1788826883) [13155.587681] Key type lgssc unregistered [13155.848127] LNet: 296957:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13155.852681] LNetError: 296957:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13155.864661] LNet: Removed LNI 192.168.201.28@tcp [13156.306755] Key type .llcrypt unregistered [13156.308388] Key type ._llcrypt unregistered [13165.450372] Key type ._llcrypt registered [13165.468225] Key type .llcrypt registered [13165.892107] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13165.903831] alg: No test for adler32 (adler32-zlib) [13166.813741] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [13166.957225] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [13168.576794] Key type lgssc registered [13169.479216] Lustre: Echo OBD driver; http://www.lustre.org/ [13211.592957] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13215.267536] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13232.046994] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13428.842503] LNet: Added LNI 192.168.201.28@tcp50 [8/256/0/180] [13430.272670] LNet: Removed LNI 192.168.201.28@tcp [13432.111763] Lustre: 301331:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8f939227d800: config has no valid NIDs, force dynamic NIDs [13433.260069] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [13433.382612] Lustre: Unmounted lustre-client [13435.407743] Key type lgssc unregistered [13435.634411] LNet: 301588:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13435.638976] LNetError: 301588:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13436.709652] LNet: Removed LNI 192.168.201.28@tcp50 [13437.260826] Key type .llcrypt unregistered [13437.265447] Key type ._llcrypt unregistered [13450.785356] Key type ._llcrypt registered [13450.787434] Key type .llcrypt registered [13451.098468] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13451.111310] alg: No test for adler32 (adler32-zlib) [13452.068685] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [13452.244592] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [13453.879514] Key type lgssc registered [13454.689751] Lustre: Echo OBD driver; http://www.lustre.org/ [13489.176673] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13492.827344] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13497.148682] LNet: Added LNI 192.168.201.28@tcp50 [8/256/0/180] [13497.728814] LNet: Removed LNI 192.168.201.28@tcp [13498.899694] Lustre: 304266:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8f9385c4e800: config has no valid NIDs, force dynamic NIDs [13500.031368] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [13500.386087] Lustre: Unmounted lustre-client [13521.929396] Key type lgssc unregistered [13522.226837] LNet: 305134:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13522.234329] LNetError: 305134:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13522.246530] LNet: Removed LNI 192.168.201.28@tcp50 [13522.708105] Key type .llcrypt unregistered [13522.709053] Key type ._llcrypt unregistered [13530.393561] Key type ._llcrypt registered [13530.395492] Key type .llcrypt registered [13531.229970] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 20:27:49 (1788827269) [13542.932421] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13542.946873] alg: No test for adler32 (adler32-zlib) [13543.912719] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [13544.098299] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [13545.759226] Key type lgssc registered [13546.513651] Lustre: Echo OBD driver; http://www.lustre.org/ [13599.708490] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13603.048738] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13617.076476] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13650.198387] Key type lgssc unregistered [13650.337791] LNet: 309866:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13650.342332] LNetError: 309866:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13650.363887] LNet: Removed LNI 192.168.201.28@tcp [13650.804782] Key type .llcrypt unregistered [13650.806330] Key type ._llcrypt unregistered [13659.065689] Key type ._llcrypt registered [13659.067211] Key type .llcrypt registered [13659.890587] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 20:29:58 (1788827398) [13661.266133] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13661.295776] alg: No test for adler32 (adler32-zlib) [13662.254891] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [13662.431290] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [13664.072072] Key type lgssc registered [13664.887246] Lustre: Echo OBD driver; http://www.lustre.org/ [13698.240077] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13702.344795] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13716.642772] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13728.299718] Lustre: Mounted lustre-client - version 2.17.58_40_gea5fd3f [13765.605680] Lustre: Mounted fs15246-client - version 2.17.58_40_gea5fd3f [13775.306939] Lustre: Unmounted fs15246-client [13793.039505] Lustre: Unmounted lustre-client [13814.111188] Key type lgssc unregistered [13814.347230] LNet: 314711:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13814.350951] LNetError: 314711:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13814.376971] LNet: Removed LNI 192.168.201.28@tcp [13814.805832] Key type .llcrypt unregistered [13814.807352] Key type ._llcrypt unregistered [13822.274147] Key type ._llcrypt registered [13822.275634] Key type .llcrypt registered [13823.119469] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 20:32:41 (1788827561) [13824.234481] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13824.247616] alg: No test for adler32 (adler32-zlib) [13825.170511] Lustre: Lustre: Build Version: 2.17.58_40_gea5fd3f [13825.312709] LNet: Added LNI 192.168.201.28@tcp [8/256/0/180] [13826.927254] Key type lgssc registered [13827.644872] Lustre: Echo OBD driver; http://www.lustre.org/ [13902.668797] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13905.523930] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13919.859756] Lustre: DEBUG MARKER: oleg128-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14044.558367] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 13781 sec ========= 20:36:22 (1788827782) [14046.119986] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 20:36:24 (1788827784) === [14049.071736] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 20:36:27 (1788827787) === [14079.926842] Key type lgssc unregistered [14080.255561] LNet: 323956:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14080.263045] LNetError: 323956:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14080.279465] LNet: Removed LNI 192.168.201.28@tcp [14080.805535] Key type .llcrypt unregistered [14080.808219] Key type ._llcrypt unregistered