[ 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 445002149 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001014] APIC: Switch to symmetric I/O mode setup [ 0.003270] x2apic enabled [ 0.004016] Switched APIC routing to physical x2apic. [ 0.005019] kvm-guest: setup PV IPIs [ 0.007000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008018] pid_max: default: 32768 minimum: 301 [ 0.010195] LSM: Security Framework initializing [ 0.012010] Yama: becoming mindful. [ 0.012886] SELinux: Initializing. [ 0.014096] *** VALIDATE selinux *** [ 0.024042] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.030669] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.031235] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032202] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.033192] *** VALIDATE tmpfs *** [ 0.035324] *** VALIDATE proc *** [ 0.036448] *** VALIDATE cgroup *** [ 0.038032] *** VALIDATE cgroup2 *** [ 0.040068] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.042228] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.043018] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.044058] Spectre V2 : User space: Vulnerable [ 0.045015] Speculative Store Bypass: Vulnerable [ 0.048457] debug: unmapping init [mem 0xffffffff9fc59000-0xffffffff9fc60fff] [ 0.050249] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.051811] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.052047] ... version: 2 [ 0.053023] ... bit width: 48 [ 0.054019] ... generic registers: 4 [ 0.055021] ... value mask: 0000ffffffffffff [ 0.056026] ... max period: 00007fffffffffff [ 0.057031] ... fixed-purpose events: 3 [ 0.058022] ... event mask: 000000070000000f [ 0.059437] rcu: Hierarchical SRCU implementation. [ 0.061883] smp: Bringing up secondary CPUs ... [ 0.062777] x86: Booting SMP configuration: [ 0.063036] .... node #0, CPUs: #1 #2 #3 [ 0.066709] smp: Brought up 1 node, 4 CPUs [ 0.068017] smpboot: Max logical packages: 1 [ 0.069019] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.153206] node 0 deferred pages initialised in 81ms [ 0.158132] devtmpfs: initialized [ 0.159337] x86/mm: Memory block size: 128MB [ 0.162919] gcov: version magic: 0x41383552 [ 0.166253] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.167103] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.169235] pinctrl core: initialized pinctrl subsystem [ 0.171231] [ 0.171728] ************************************************************* [ 0.174017] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.177014] ** ** [ 0.179014] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.182014] ** ** [ 0.184013] ** This means that this kernel is built to expose internal ** [ 0.187012] ** IOMMU data structures, which may compromise security on ** [ 0.189012] ** your system. ** [ 0.192014] ** ** [ 0.194011] ** If you see this message and you are not debugging the ** [ 0.197018] ** kernel, report this immediately to your vendor! ** [ 0.199012] ** ** [ 0.201015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.204014] ************************************************************* [ 0.206830] NET: Registered protocol family 16 [ 0.209447] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.212062] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.215089] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.218028] cpuidle: using governor menu [ 0.219537] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.223571] PCI: Using configuration type 1 for base access [ 0.225132] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.237085] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.240095] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.244095] cryptd: max_cpu_qlen set to 1000 [ 0.248266] ACPI: Added _OSI(Module Device) [ 0.249019] ACPI: Added _OSI(Processor Device) [ 0.251016] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.253016] ACPI: Added _OSI(Processor Aggregator Device) [ 0.258409] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.264525] ACPI: Interpreter enabled [ 0.266081] ACPI: PM: (supports S0 S3 S4 S5) [ 0.268014] ACPI: Using IOAPIC for interrupt routing [ 0.269125] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.272480] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.283316] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.286044] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.288018] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.291081] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.296504] acpiphp: Slot [2] registered [ 0.298141] acpiphp: Slot [5] registered [ 0.300166] acpiphp: Slot [6] registered [ 0.302135] acpiphp: Slot [3] registered [ 0.303118] acpiphp: Slot [4] registered [ 0.304114] acpiphp: Slot [7] registered [ 0.306119] acpiphp: Slot [8] registered [ 0.308226] acpiphp: Slot [9] registered [ 0.309109] acpiphp: Slot [10] registered [ 0.311114] acpiphp: Slot [11] registered [ 0.312163] acpiphp: Slot [12] registered [ 0.314115] acpiphp: Slot [13] registered [ 0.316113] acpiphp: Slot [14] registered [ 0.317149] acpiphp: Slot [15] registered [ 0.319391] acpiphp: Slot [16] registered [ 0.321140] acpiphp: Slot [17] registered [ 0.322133] acpiphp: Slot [18] registered [ 0.324153] acpiphp: Slot [19] registered [ 0.325206] acpiphp: Slot [20] registered [ 0.327167] acpiphp: Slot [21] registered [ 0.329154] acpiphp: Slot [22] registered [ 0.330144] acpiphp: Slot [23] registered [ 0.332176] acpiphp: Slot [24] registered [ 0.334114] acpiphp: Slot [25] registered [ 0.335121] acpiphp: Slot [26] registered [ 0.337099] acpiphp: Slot [27] registered [ 0.338119] acpiphp: Slot [28] registered [ 0.339104] acpiphp: Slot [29] registered [ 0.341135] acpiphp: Slot [30] registered [ 0.342094] acpiphp: Slot [31] registered [ 0.344059] PCI host bridge to bus 0000:00 [ 0.345021] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.347022] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.350030] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.353033] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.355028] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.358034] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.360302] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.364097] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.367564] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.375614] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.380240] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.383034] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.385029] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.388040] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.391296] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.394881] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.398059] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.400845] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.406014] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.416026] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.420017] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.426211] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.438023] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.447021] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.463028] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.472856] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.479029] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.485026] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.499021] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.508798] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.511437] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.513649] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.516230] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.518175] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.522033] iommu: Default domain type: Passthrough [ 0.524346] SCSI subsystem initialized [ 0.525095] ACPI: bus type USB registered [ 0.526166] usbcore: registered new interface driver usbfs [ 0.528099] usbcore: registered new interface driver hub [ 0.529125] usbcore: registered new device driver usb [ 0.531260] pps_core: LinuxPPS API ver. 1 registered [ 0.533010] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.535129] PTP clock support registered [ 0.538009] EDAC MC: Ver: 3.0.0 [ 0.539148] PCI: Using ACPI for IRQ routing [ 0.540560] NetLabel: Initializing [ 0.542017] NetLabel: domain hash size = 128 [ 0.543010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.545151] NetLabel: unlabeled traffic allowed by default [ 0.547198] vgaarb: loaded [ 0.549248] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.550009] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.555004] clocksource: Switched to clocksource kvm-clock [ 0.665997] VFS: Disk quotas dquot_6.6.0 [ 0.667635] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.670275] *** VALIDATE ramfs *** [ 0.671432] *** VALIDATE hugetlbfs *** [ 0.672925] pnp: PnP ACPI init [ 0.675311] pnp: PnP ACPI: found 6 devices [ 0.715990] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.719516] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.721884] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.723913] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.725729] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.727534] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.729202] NET: Registered protocol family 2 [ 0.730822] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.734129] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.736731] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.740799] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.743550] TCP: Hash tables configured (established 65536 bind 65536) [ 0.746271] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.748535] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.750452] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.752780] NET: Registered protocol family 1 [ 0.755717] RPC: Registered named UNIX socket transport module. [ 0.758116] RPC: Registered udp transport module. [ 0.759989] RPC: Registered tcp transport module. [ 0.762012] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.764850] NET: Registered protocol family 44 [ 0.766654] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.769025] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.771529] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.774303] PCI: CLS 0 bytes, default 64 [ 0.776112] Unpacking initramfs... [ 2.153454] debug: unmapping init [mem 0xffff8d06bcc64000-0xffff8d06bffcffff] [ 2.156365] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.157982] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.160790] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.683579] Initialise system trusted keyrings [ 2.685493] Key type blacklist registered [ 2.687744] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.698216] zbud: loaded [ 2.701473] *** VALIDATE nfs *** [ 2.703295] *** VALIDATE nfs4 *** [ 2.705593] pstore: using deflate compression [ 2.709386] Platform Keyring initialized [ 2.799203] NET: Registered protocol family 38 [ 2.800424] Key type asymmetric registered [ 2.801435] Asymmetric key parser 'x509' registered [ 2.803118] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.805437] io scheduler mq-deadline registered [ 2.806497] io scheduler kyber registered [ 2.807845] io scheduler bfq registered [ 2.809052] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.810993] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.813068] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.814911] ACPI: Power Button [PWRF] [ 2.818697] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.823348] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.830294] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.857104] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.883755] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.888686] Non-volatile memory driver v1.3 [ 2.889855] Linux agpgart interface v0.103 [ 2.916714] virtio_blk virtio1: [vda] 145896 512-byte logical blocks (74.7 MB/71.2 MiB) [ 2.919066] vda: detected capacity change from 0 to 74698752 [ 2.937463] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.940504] vdb: detected capacity change from 0 to 1073741824 [ 2.947990] libphy: Fixed MDIO Bus: probed [ 2.964481] usbcore: registered new interface driver usbserial_generic [ 2.966487] usbserial: USB Serial support registered for generic [ 2.968899] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.972349] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.974076] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.976671] mousedev: PS/2 mouse device common for all mice [ 2.979530] rtc_cmos 00:05: RTC can wake from S4 [ 2.982930] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.982974] rtc_cmos 00:05: registered as rtc0 [ 2.987389] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.988616] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.991156] intel_pstate: CPU model not supported [ 2.995490] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.999430] hid: raw HID events driver (C) Jiri Kosina [ 3.001774] usbcore: registered new interface driver usbhid [ 3.003988] usbhid: USB HID core driver [ 3.005839] drop_monitor: Initializing network drop monitor service [ 3.008497] Initializing XFRM netlink socket [ 3.010611] NET: Registered protocol family 10 [ 3.013666] Segment Routing with IPv6 [ 3.014793] NET: Registered protocol family 17 [ 3.016404] mpls_gso: MPLS GSO support [ 3.021127] RAS: Correctable Errors collector initialized. [ 3.022840] AVX version of gcm_enc/dec engaged. [ 3.023900] AES CTR mode by8 optimization enabled [ 3.088663] sched_clock: Marking stable (3088635756, 0)->(3989990861, -901355105) [ 3.091737] registered taskstats version 1 [ 3.093407] Loading compiled-in X.509 certificates [ 3.095062] zswap: loaded using pool lzo/zbud [ 3.118801] Key type big_key registered [ 3.130926] Key type encrypted registered [ 3.132596] ima: No TPM chip found, activating TPM-bypass! [ 3.134675] ima: Allocated hash algorithm: sha1 [ 3.135903] ima: No architecture policies found [ 3.137144] evm: Initialising EVM extended attributes: [ 3.138667] evm: security.selinux [ 3.139749] evm: security.ima [ 3.140432] evm: security.capability [ 3.141257] evm: HMAC attrs: 0x1 [ 3.143429] rtc_cmos 00:05: setting system clock to 2026-08-14 06:31:15 UTC (1786689075) [ 3.151426] debug: unmapping init [mem 0xffffffffa0c03000-0xffffffffa0dfffff] [ 3.154770] debug: unmapping init [mem 0xffffffff9f982000-0xffffffff9fc58fff] [ 3.164113] Write protecting the kernel read-only data: 28672k [ 3.167570] debug: unmapping init [mem 0xffffffff9e003000-0xffffffff9e1fffff] [ 3.170403] debug: unmapping init [mem 0xffffffff9e914000-0xffffffff9e9fffff] [ 3.198424] 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.205497] systemd[1]: Detected virtualization kvm. [ 3.207196] systemd[1]: Detected architecture x86-64. [ 3.208608] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.232591] systemd[1]: No hostname configured. [ 3.234434] systemd[1]: Set hostname to . [ 3.236333] random: systemd: uninitialized urandom read (16 bytes read) [ 3.238644] systemd[1]: Initializing machine ID from random generator. [ 3.365122] random: systemd: uninitialized urandom read (16 bytes read) [ 3.368226] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.373413] random: systemd: uninitialized urandom read (16 bytes read) [ 3.376029] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.379974] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket. Starting Journal Service... Starting Create list of required st…ce nodes for the current kernel... Starting Create Volatile Files and Directories... Starting Setup Virtual Console... [ OK ] Reached target Initrd Root Device. [ OK ] Listening on udev Kernel Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Starting Apply Kernel Variables... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. 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.998207] device-mapper: uevent: version 1.0.3 [ 4.000398] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook.[ 4.240634] random: fast init done 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.675438] virtio_net virtio0 ens2: renamed from eth0 [ 4.708278] scsi host0: ata_piix [ 4.720515] scsi host1: ata_piix [ 4.722062] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.724424] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.994355] dracut-initqueue[583]: RTNETLINK answers: File exists [ 9.650975] random: crng init done [ 9.653270] 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.920096] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ 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 target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Swap. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ 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... [ 11.065651] printk: systemd: 24 output lines suppressed due to ratelimiting [ 11.387443] SELinux: Disabled at runtime. [ 11.448899] 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.459455] systemd[1]: Detected virtualization kvm. [ 11.461534] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.928174] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.930263] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.933786] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.936383] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.938560] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.945183] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.957068] systemd[1]: Listening on initctl Compatibility Named Pipe. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on Process Core Dump Socket. [ 12.015444] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Starting Create list of required st…ce nodes for the current kernel... Mounting POSIX Message Queue File System... [ OK ] Listening on udev Control Socket. [ OK ] Created slice system-getty.slice. [ OK ] Reached target Local Encrypted Volumes. Mounting Kernel Debug File System... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Reached target Paths. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target rpc_pipefs.target. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Created slice User and Session Slice. Starting Remount Root and Kernel File Systems... [ OK ] Reached target RPC Port Mapper. Mounting Huge Pages File System... [ OK ] Reached target Slices. Starting Apply Kernel Variables... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue 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 ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 12.353675] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.636342] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.711444] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.755785] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.774040] EDAC sbridge: Ver: 1.1.2 [ 13.776327] Key type dns_resolver registered [ 14.084527] NFS: Registering the id_resolver key type [ 14.086645] Key type id_resolver registered [ 14.088011] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting 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 oleg206-client login: [ 43.024608] libcfs: loading out-of-tree module taints kernel. [ 43.114623] Key type ._llcrypt registered [ 43.115925] Key type .llcrypt registered [ 43.331111] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 43.337833] alg: No test for adler32 (adler32-zlib) [ 44.380624] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 44.739464] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 46.367213] Key type lgssc registered [ 47.121881] Lustre: Echo OBD driver; http://www.lustre.org/ [ 92.745038] hrtimer: interrupt took 5027772 ns [ 206.143851] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 211.596836] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 226.968474] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing check_logdir /tmp/testlogs/ [ 231.915862] Lustre: lustre-OST0000-osc-ffff8d0703117800: disconnect after 23s idle [ 233.012700] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing yml_node [ 238.509650] Lustre: DEBUG MARKER: Client: 2.17.57.1 [ 241.933678] Lustre: DEBUG MARKER: MDS: 2.17.57.1 [ 245.208385] Lustre: DEBUG MARKER: OSS: 2.17.57.1 [ 247.365275] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Aug 14 02:35:17 EDT 2026 [ 266.031956] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 267.826842] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 270.201559] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 280.569041] Lustre: Unmounted lustre-client [ 402.543543] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 409.725387] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 434.290906] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 474.811666] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 02:39:05 (1786689545) [ 477.512799] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 479.114298] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 02:39:10 (1786689550) [ 513.432942] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 519.742912] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 543.386813] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 544.322292] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 554.326337] Lustre: Unmounted lustre-client [ 583.218033] Key type lgssc unregistered [ 583.540478] LNet: 15046:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 583.549386] LNetError: 15046:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 583.579425] LNet: Removed LNI 192.168.202.6@tcp [ 584.512266] Key type .llcrypt unregistered [ 584.514739] Key type ._llcrypt unregistered [ 601.172710] Key type ._llcrypt registered [ 601.174825] Key type .llcrypt registered [ 602.768212] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 02:41:13 (1786689673) [ 604.339856] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 604.394151] alg: No test for adler32 (adler32-zlib) [ 605.552373] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 605.907118] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 607.641965] Key type lgssc registered [ 609.538131] Lustre: Echo OBD driver; http://www.lustre.org/ [ 691.242652] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 781.014853] Lustre: Unmounted lustre-client [ 815.293523] Key type lgssc unregistered [ 815.610082] LNet: 18831:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 815.614685] LNetError: 18831:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 815.636280] LNet: Removed LNI 192.168.202.6@tcp [ 816.456935] Key type .llcrypt unregistered [ 816.459798] Key type ._llcrypt unregistered [ 829.048653] Key type ._llcrypt registered [ 829.052619] Key type .llcrypt registered [ 830.415532] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 02:45:01 (1786689901) [ 832.916363] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 832.936295] alg: No test for adler32 (adler32-zlib) [ 834.099938] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 834.489718] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 836.199483] Key type lgssc registered [ 837.353520] Lustre: Echo OBD driver; http://www.lustre.org/ [ 890.930195] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 896.548227] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 919.000615] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 921.874117] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 940.483705] Lustre: Unmounted lustre-client [ 971.788189] Key type lgssc unregistered [ 972.085786] LNet: 22443:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 972.094780] LNetError: 22443:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 972.115165] LNet: Removed LNI 192.168.202.6@tcp [ 972.993262] Key type .llcrypt unregistered [ 972.998451] Key type ._llcrypt unregistered [ 985.309636] Key type ._llcrypt registered [ 985.312567] Key type .llcrypt registered [ 987.175789] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 02:47:37 (1786690057) [ 989.784162] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 990.059453] alg: No test for adler32 (adler32-zlib) [ 991.368569] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 991.771452] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 993.503221] Key type lgssc registered [ 995.248957] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1058.391326] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1066.700799] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1092.512309] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1095.743626] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 1102.946158] Lustre: Unmounted lustre-client [ 1137.303316] Key type lgssc unregistered [ 1137.619140] LNet: 25643:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1137.641137] LNetError: 25643:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1138.663968] LNet: Removed LNI 192.168.202.6@tcp [ 1139.190912] Key type .llcrypt unregistered [ 1139.193961] Key type ._llcrypt unregistered [ 1159.240657] Key type ._llcrypt registered [ 1159.246581] Key type .llcrypt registered [ 1160.739961] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 02:50:31 (1786690231) [ 1163.792598] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1163.844100] alg: No test for adler32 (adler32-zlib) [ 1164.953082] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 1165.322226] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 1167.039245] Key type lgssc registered [ 1168.257788] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1229.105122] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1236.243776] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1261.277967] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1272.953802] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 1283.052609] Lustre: lustre-MDT0000-mdc-ffff8d0711014000: Connection to lustre-MDT0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1287.963927] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1298.243848] LustreError: MGC192.168.202.106@tcp: Connection to MGS (at 192.168.202.106@tcp) was lost; in progress operations using this service will fail [ 1298.326307] Lustre: Unmounted lustre-client [ 1329.790830] Key type lgssc unregistered [ 1330.099915] LNet: 29307:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1330.120866] LNetError: 29307:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1330.142650] LNet: Removed LNI 192.168.202.6@tcp [ 1331.291110] Key type .llcrypt unregistered [ 1331.292698] Key type ._llcrypt unregistered [ 1350.305273] Key type ._llcrypt registered [ 1350.312799] Key type .llcrypt registered [ 1352.053526] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 02:53:42 (1786690422) [ 1355.351811] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1355.369535] alg: No test for adler32 (adler32-zlib) [ 1356.513621] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 1356.833690] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 1358.679218] Key type lgssc registered [ 1360.366363] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1423.507432] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1431.650978] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1459.834659] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1462.015538] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 1467.371626] Lustre: lustre-OST0000-osc-ffff8d0706739800: Connection to lustre-OST0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1474.082092] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1484.466134] Lustre: Unmounted lustre-client [ 1524.079579] Key type lgssc unregistered [ 1524.376306] LNet: 32928:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1524.381894] LNetError: 32928:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1525.434227] LNet: Removed LNI 192.168.202.6@tcp [ 1526.614087] Key type .llcrypt unregistered [ 1526.617130] Key type ._llcrypt unregistered [ 1546.740688] Key type ._llcrypt registered [ 1546.743492] Key type .llcrypt registered [ 1548.336511] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 02:56:58 (1786690618) [ 1551.313932] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1551.438180] alg: No test for adler32 (adler32-zlib) [ 1552.746931] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 1553.140173] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 1554.935518] Key type lgssc registered [ 1556.453994] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1617.028474] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1624.787803] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1648.028236] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1659.442817] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 1664.120764] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1668.762549] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1680.817679] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-14 2h59m11s [ 1683.392661] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1690.090493] Lustre: lustre-MDT0000-mdc-ffff8d0706736800: Connection to lustre-MDT0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1703.036795] LustreError: 36725:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8d0706736800: can't stat MDS #0: rc = -19 [ 1705.023647] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1715.686987] LustreError: MGC192.168.202.106@tcp: Connection to MGS (at 192.168.202.106@tcp) was lost; in progress operations using this service will fail [ 1715.703926] LustreError: lustre-MDT0000-mdc-ffff8d0706736800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1715.745736] Lustre: Evicted from MGS (at 192.168.202.106@tcp) after server handle changed from 0x4ed17f583b4036cc to 0x4ed17f583b403a5a [ 1715.749703] Lustre: lustre-MDT0000-mdc-ffff8d0706736800: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [ 1715.770572] Lustre: Skipped 1 previous similar message [ 1726.029630] Lustre: DEBUG MARKER: Wait for df (36725) ... [ 1727.773252] Lustre: DEBUG MARKER: done [ 1729.287737] Lustre: Unmounted lustre-client [ 1775.570834] Key type lgssc unregistered [ 1775.921284] LNet: 37748:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1775.931574] LNetError: 37748:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1775.960458] LNet: Removed LNI 192.168.202.6@tcp [ 1776.955853] Key type .llcrypt unregistered [ 1776.958881] Key type ._llcrypt unregistered [ 1814.352419] Key type ._llcrypt registered [ 1814.359394] Key type .llcrypt registered [ 1816.106711] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 03:01:26 (1786690886) [ 1819.815726] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1819.855582] alg: No test for adler32 (adler32-zlib) [ 1821.090505] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 1821.485358] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 1823.231312] Key type lgssc registered [ 1824.920627] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1884.451695] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1892.157649] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1915.763231] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1918.459412] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 1923.804823] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-14 3h03m14s [ 1926.158547] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1934.650363] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1938.023591] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1958.367166] Lustre: 41912:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786691010/real 1786691010] req@00000000730c0009 x1873481189825152/t0(0) o101->lustre-MDT0000-mdc-ffff8d0711d1c800@192.168.202.106@tcp:12/10 lens 576/1152 e 0 to 1 dl 1786691030 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1958.408983] Lustre: lustre-MDT0000-mdc-ffff8d0711d1c800: Connection to lustre-MDT0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1958.466503] Lustre: lustre-MDT0000-mdc-ffff8d0711d1c800: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [ 1981.169917] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1985.370052] Lustre: DEBUG MARKER: done [ 1990.362934] Lustre: Unmounted lustre-client [ 2019.782310] Key type lgssc unregistered [ 2020.131745] LNet: 42798:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2020.143409] LNetError: 42798:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2020.200190] LNet: Removed LNI 192.168.202.6@tcp [ 2021.096484] Key type .llcrypt unregistered [ 2021.100979] Key type ._llcrypt unregistered [ 2058.697816] Key type ._llcrypt registered [ 2058.703296] Key type .llcrypt registered [ 2060.562489] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 03:05:30 (1786691130) [ 2063.086092] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2066.045813] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 03:05:35 (1786691135) [ 2071.469603] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2071.492993] alg: No test for adler32 (adler32-zlib) [ 2072.765668] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 2073.104351] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 2074.952411] Key type lgssc registered [ 2076.689500] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2110.974933] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 03:06:21 (1786691181) [ 2146.671289] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2153.384887] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2177.068582] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2179.080045] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 2183.511560] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2188.375932] Lustre: Unmounted lustre-client [ 2208.178451] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2258.973876] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2265.383516] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2266.044334] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 2271.168395] Lustre: Unmounted lustre-client [ 2353.462358] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2361.474983] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2362.211442] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 2366.507699] Lustre: Unmounted lustre-client [ 2390.712797] Lustre: DEBUG MARKER: files compared the same [ 2415.148290] Key type lgssc unregistered [ 2415.525619] LNet: 50435:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2415.548160] LNetError: 50435:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2415.578136] LNet: Removed LNI 192.168.202.6@tcp [ 2416.583513] Key type .llcrypt unregistered [ 2416.584933] Key type ._llcrypt unregistered [ 2434.748534] Key type ._llcrypt registered [ 2434.755316] Key type .llcrypt registered [ 2436.420869] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 03:11:46 (1786691506) [ 2439.330317] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2439.429272] alg: No test for adler32 (adler32-zlib) [ 2440.634221] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 2441.111045] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 2442.935677] Key type lgssc registered [ 2444.668410] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2508.867987] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2517.561602] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2547.368630] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2550.069799] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 2555.278513] Lustre: Unmounted lustre-client [ 2593.718150] Key type lgssc unregistered [ 2593.918210] LNet: 54035:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2593.928129] LNetError: 54035:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2593.959850] LNet: Removed LNI 192.168.202.6@tcp [ 2595.300735] Key type .llcrypt unregistered [ 2595.308833] Key type ._llcrypt unregistered [ 2618.572479] Key type ._llcrypt registered [ 2618.575504] Key type .llcrypt registered [ 2620.567640] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 03:14:50 (1786691690) [ 2624.302905] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2624.330564] alg: No test for adler32 (adler32-zlib) [ 2625.475593] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 2625.889510] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 2627.695210] Key type lgssc registered [ 2629.942734] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2727.471797] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2772.001658] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2780.668755] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2819.847839] Key type lgssc unregistered [ 2820.287894] LNet: 57531:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2820.301083] LNetError: 57531:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2820.324061] LNet: Removed LNI 192.168.202.6@tcp [ 2821.650932] Key type .llcrypt unregistered [ 2821.657518] Key type ._llcrypt unregistered [ 2847.992803] Key type ._llcrypt registered [ 2847.999298] Key type .llcrypt registered [ 2849.806587] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 03:18:40 (1786691920) [ 2854.564108] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2854.746894] alg: No test for adler32 (adler32-zlib) [ 2856.053405] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 2856.460556] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 2858.399222] Key type lgssc registered [ 2860.526119] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2954.768150] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 2963.573242] Lustre: Unmounted lustre-client [ 3010.009230] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 03:21:20 (1786692080) [ 3157.788446] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3178.382408] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 3186.207964] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3186.213796] LustreError: 64014:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8d0706759000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3186.232272] Lustre: 58520:0:(llite_lib.c:4340:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.106@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3196.703823] Lustre: Unmounted lustre-client [ 3272.811665] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 03:25:43 (1786692343) [ 3286.272287] Key type lgssc unregistered [ 3286.657851] LNet: 65234:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3286.662058] LNetError: 65234:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3286.684493] LNet: Removed LNI 192.168.202.6@tcp [ 3287.535976] Key type .llcrypt unregistered [ 3287.538322] Key type ._llcrypt unregistered [ 3302.662258] Key type ._llcrypt registered [ 3302.668426] Key type .llcrypt registered [ 3303.136122] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3303.148982] alg: No test for adler32 (adler32-zlib) [ 3304.289890] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 3304.566533] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 3306.345263] Key type lgssc registered [ 3307.666833] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3363.910848] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3371.155383] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3393.785330] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3404.836690] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 3409.134178] Lustre: Unmounted lustre-client [ 3437.419131] Key type lgssc unregistered [ 3437.737477] LNet: 68252:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3437.748862] LNetError: 68252:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3438.767707] LNet: Removed LNI 192.168.202.6@tcp [ 3439.525480] Key type .llcrypt unregistered [ 3439.528927] Key type ._llcrypt unregistered [ 3450.460827] Key type ._llcrypt registered [ 3450.466038] Key type .llcrypt registered [ 3451.098807] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3451.110715] alg: No test for adler32 (adler32-zlib) [ 3452.319788] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 3452.661910] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 3454.431400] Key type lgssc registered [ 3456.294142] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3572.914715] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3579.113474] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3600.812443] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3602.654592] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 3610.761438] Lustre: Unmounted lustre-client [ 3642.710578] Key type lgssc unregistered [ 3642.957975] LNet: 71686:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3642.965888] LNetError: 71686:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3642.982280] LNet: Removed LNI 192.168.202.6@tcp [ 3643.970594] Key type .llcrypt unregistered [ 3643.972705] Key type ._llcrypt unregistered [ 3663.141775] Key type ._llcrypt registered [ 3663.143381] Key type .llcrypt registered [ 3664.670421] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 03:32:15 (1786692735) [ 3668.181109] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3668.244855] alg: No test for adler32 (adler32-zlib) [ 3669.739996] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 3670.427804] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 3672.231223] Key type lgssc registered [ 3674.455492] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3734.724951] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3740.742268] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3766.096649] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3768.933360] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 3776.258219] Lustre: Unmounted lustre-client [ 3777.070862] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 3780.584868] Lustre: Unmounted lustre-client [ 3819.800788] Key type lgssc unregistered [ 3820.197143] LNet: 75377:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3820.206789] LNetError: 75377:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3820.243155] LNet: Removed LNI 192.168.202.6@tcp [ 3821.039220] Key type .llcrypt unregistered [ 3821.048142] Key type ._llcrypt unregistered [ 3835.185147] Key type ._llcrypt registered [ 3835.196876] Key type .llcrypt registered [ 3835.859573] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3835.879695] alg: No test for adler32 (adler32-zlib) [ 3837.020463] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 3837.444699] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 3839.164081] Key type lgssc registered [ 3840.705313] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3900.019763] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3907.568584] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3929.768964] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3940.975578] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 3945.158115] Lustre: Unmounted lustre-client [ 3976.432663] Key type lgssc unregistered [ 3977.046279] LNet: 78411:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3977.064623] LNetError: 78411:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3977.090439] LNet: Removed LNI 192.168.202.6@tcp [ 3978.428355] Key type .llcrypt unregistered [ 3978.431621] Key type ._llcrypt unregistered [ 3997.973469] Key type ._llcrypt registered [ 3997.977932] Key type .llcrypt registered [ 3999.311699] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 03:37:50 (1786693070) [ 4001.997995] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4002.187899] alg: No test for adler32 (adler32-zlib) [ 4003.376793] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 4003.735752] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 4005.479483] Key type lgssc registered [ 4006.662796] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4065.013442] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4071.113624] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4094.667716] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4097.696318] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 4111.918693] Lustre: lustre: root_squash is set to 0:0 [ 4111.972338] Lustre: lustre: nosquash_nids is cleared [ 4120.637978] Lustre: lustre: root_squash is set to 500:500 [ 4128.160334] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.6@tcp 192.168.0.[2,10]@tcp [ 4137.030333] Lustre: lustre: nosquash_nids set to 192.168.202.6/24@tcp [ 4142.005873] Lustre: Unmounted lustre-client [ 4181.346711] Key type lgssc unregistered [ 4181.733267] LNet: 82342:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4181.752728] LNetError: 82342:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4181.774149] LNet: Removed LNI 192.168.202.6@tcp [ 4182.792338] Key type .llcrypt unregistered [ 4182.795464] Key type ._llcrypt unregistered [ 4200.925115] Key type ._llcrypt registered [ 4200.926874] Key type .llcrypt registered [ 4202.459356] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 03:41:13 (1786693273) [ 4205.595272] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 4207.925767] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 03:41:18 (1786693278) [ 4211.329173] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4211.360378] alg: No test for adler32 (adler32-zlib) [ 4212.578995] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 4212.982930] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 4214.672419] Key type lgssc registered [ 4215.934242] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4277.275538] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4285.496401] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4309.729717] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4311.489440] Lustre: lustre: root_squash is set to 500:500 [ 4311.525432] Lustre: lustre: nosquash_nids set to 192.168.202.6/24@tcp [ 4316.768217] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 4323.380641] Lustre: Unmounted lustre-client [ 4355.269609] Key type lgssc unregistered [ 4355.554860] LNet: 86311:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4355.566621] LNetError: 86311:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4355.596727] LNet: Removed LNI 192.168.202.6@tcp [ 4356.916476] Key type .llcrypt unregistered [ 4356.917976] Key type ._llcrypt unregistered [ 4374.744772] Key type ._llcrypt registered [ 4374.747789] Key type .llcrypt registered [ 4376.547749] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4378.460371] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 03:44:09 (1786693449) [ 4401.145358] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4401.179579] alg: No test for adler32 (adler32-zlib) [ 4402.355958] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 4402.577710] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 4404.247902] Key type lgssc registered [ 4405.869652] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4495.608578] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4502.834632] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4528.175559] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4618.707520] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4626.176755] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4648.666809] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4661.499548] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 4698.352586] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8d0708522800.ost_server_uuid 50 [ 4700.304602] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8d0708522800.ost_server_uuid in IDLE state after 0 sec [ 4701.012752] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 4705.704164] Lustre: Unmounted lustre-client [ 4708.544565] Lustre: Unmounted lustre-client [ 4768.436334] Key type lgssc unregistered [ 4768.772647] LNet: 93987:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4768.776661] LNetError: 93987:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4768.791168] LNet: Removed LNI 192.168.202.6@tcp [ 4769.404167] Key type .llcrypt unregistered [ 4769.406929] Key type ._llcrypt unregistered [ 4804.989585] Key type ._llcrypt registered [ 4804.997667] Key type .llcrypt registered [ 4806.396547] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 03:51:17 (1786693877) [ 4827.405967] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4827.435383] alg: No test for adler32 (adler32-zlib) [ 4828.532911] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 4828.876266] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 4830.599190] Key type lgssc registered [ 4832.176596] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4929.341596] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4936.471384] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4962.264516] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4964.955834] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 4986.143224] Lustre: 95353:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786694042/real 1786694042] req@00000000d841876d x1873484343940352/t0(0) o400->lustre-OST0000-osc-ffff8d0709b60800@192.168.202.106@tcp:28/4 lens 224/224 e 0 to 1 dl 1786694058 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4986.180911] Lustre: lustre-OST0000-osc-ffff8d0709b60800: Connection to lustre-OST0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4991.332085] Lustre: 95354:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786694047/real 1786694047] req@00000000339e5022 x1873484343940864/t0(0) o400->lustre-OST0000-osc-ffff8d0709b60800@192.168.202.106@tcp:28/4 lens 224/224 e 0 to 1 dl 1786694063 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4996.518063] Lustre: 95354:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786694052/real 1786694052] req@0000000083df7104 x1873484343941376/t0(0) o400->lustre-OST0000-osc-ffff8d0709b60800@192.168.202.106@tcp:28/4 lens 224/224 e 0 to 1 dl 1786694068 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4996.633809] Lustre: lustre-OST0000-osc-ffff8d0709b60800: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [ 5000.671204] Lustre: 95354:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786694057/real 1786694057] req@000000005a4a5d39 x1873484343941888/t0(0) o400->lustre-OST0000-osc-ffff8d0709b60800@192.168.202.106@tcp:28/4 lens 224/224 e 0 to 1 dl 1786694073 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5001.702917] Lustre: lustre-MDT0000-mdc-ffff8d0709b60800: Connection to lustre-MDT0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5018.079184] Lustre: 95353:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786694074/real 1786694074] req@0000000040c2b7f7 x1873484343944064/t0(0) o400->MGC192.168.202.106@tcp@192.168.202.106@tcp:26/25 lens 224/224 e 0 to 1 dl 1786694090 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5018.112655] LustreError: MGC192.168.202.106@tcp: Connection to MGS (at 192.168.202.106@tcp) was lost; in progress operations using this service will fail [ 5028.334961] Lustre: Evicted from MGS (at 192.168.202.106@tcp) after server handle changed from 0xcdce246cd151a635 to 0xcdce246cd151a8c7 [ 5028.356836] Lustre: MGC192.168.202.106@tcp: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [ 5032.373491] Lustre: lustre-MDT0000-mdc-ffff8d0709b60800: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [ 5039.089464] Lustre: Unmounted lustre-client [ 5068.156290] Key type lgssc unregistered [ 5068.488231] LNet: 99667:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5068.494704] LNetError: 99667:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5068.521278] LNet: Removed LNI 192.168.202.6@tcp [ 5069.261605] Key type .llcrypt unregistered [ 5069.263883] Key type ._llcrypt unregistered [ 5086.873449] Key type ._llcrypt registered [ 5086.876408] Key type .llcrypt registered [ 5088.699863] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 03:55:59 (1786694159) [ 5104.409787] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5104.586580] alg: No test for adler32 (adler32-zlib) [ 5105.899395] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 5106.237642] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 5107.959285] Key type lgssc registered [ 5109.338979] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5153.339199] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5262.392274] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5269.564908] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5292.887374] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5294.713348] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 5296.613204] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5298.633947] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 03:59:29 (1786694369) [ 5552.631529] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5562.978774] Lustre: Unmounted lustre-client [ 5698.765807] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5706.442840] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5736.094424] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5782.834225] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 04:07:33 (1786694853) [ 5893.446759] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5900.132742] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5926.551758] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5927.449371] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 5932.328340] Lustre: Unmounted lustre-client [ 5966.444322] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 04:10:36 (1786695036) [ 6080.376166] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6086.962272] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6110.953417] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6111.955538] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 6117.260537] Lustre: Unmounted lustre-client [ 6145.851947] Key type lgssc unregistered [ 6146.175884] LNet: 122722:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6146.195607] LNetError: 122722:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6146.217983] LNet: Removed LNI 192.168.202.6@tcp [ 6146.831944] Key type .llcrypt unregistered [ 6146.836782] Key type ._llcrypt unregistered [ 6164.769651] Key type ._llcrypt registered [ 6164.775624] Key type .llcrypt registered [ 6166.072690] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 04:13:56 (1786695236) [ 6168.801096] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6168.864505] alg: No test for adler32 (adler32-zlib) [ 6169.925614] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 6170.135607] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 6171.847424] Key type lgssc registered [ 6173.181942] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6227.566727] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6233.600832] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6259.439661] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6261.280289] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 6275.653892] Lustre: Unmounted lustre-client [ 6308.408310] Key type lgssc unregistered [ 6308.803528] LNet: 126327:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6308.812759] LNetError: 126327:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6308.835932] LNet: Removed LNI 192.168.202.6@tcp [ 6309.683640] Key type .llcrypt unregistered [ 6309.688427] Key type ._llcrypt unregistered [ 6326.523733] Key type ._llcrypt registered [ 6326.529678] Key type .llcrypt registered [ 6328.329978] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 04:16:38 (1786695398) [ 6331.042732] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6331.135214] alg: No test for adler32 (adler32-zlib) [ 6332.454833] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 6332.875875] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 6334.672500] Key type lgssc registered [ 6335.889450] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6395.328603] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6402.043453] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6425.288325] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6437.441611] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 6442.472990] Lustre: lustre-OST0000-osc-ffff8d0705b8b000: Connection to lustre-OST0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6456.550811] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8d0705b8b000.ost_server_uuid 50 [ 6457.988277] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6469.526367] Lustre: Unmounted lustre-client [ 6494.358053] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 04:19:25 (1786695565) [ 6528.304782] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6534.294253] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6560.503881] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6584.913844] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6585.668658] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 6590.967123] Lustre: lustre-OST0000-osc-ffff8d0703b76000: Connection to lustre-OST0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6630.685840] Lustre: Unmounted lustre-client [ 6676.875977] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 04:22:27 (1786695747) [ 6718.546994] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6724.844087] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6747.796941] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6771.936249] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6772.899137] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 6777.841729] Lustre: lustre-OST0000-osc-ffff8d07093d4800: Connection to lustre-OST0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6794.748269] Lustre: Unmounted lustre-client [ 6854.508825] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 04:25:25 (1786695925) [ 6960.101634] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6966.522437] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6993.245154] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7064.904308] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7070.791633] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7099.925791] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7135.736514] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 7182.807372] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7185.988646] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7188.848774] Lustre: Unmounted lustre-client [ 7219.803508] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 04:31:30 (1786696290) [ 7259.446577] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7265.282119] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7285.984759] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7326.168477] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7355.488984] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 7403.608392] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7405.611785] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7418.747564] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7429.079178] Lustre: Unmounted lustre-client [ 7487.823528] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 04:35:58 (1786696558) [ 7525.316377] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7533.521327] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7559.174988] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7559.968627] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 7587.036665] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7588.876535] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7606.459673] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8d07116b3000.ost_server_uuid 50 [ 7608.201821] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8d07116b3000.ost_server_uuid in IDLE state after 0 sec [ 7611.374405] Lustre: Unmounted lustre-client [ 7611.885712] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7611.890092] Lustre: Skipped 3 previous similar messages [ 7612.050423] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 7613.319396] LustreError: 149775:0:(sec.c:403:import_sec_validate_get()) import 0000000007f1dfb8 (NEW) with no sec [ 7675.120721] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 04:39:05 (1786696745) [ 7708.062567] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7714.630646] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7737.459042] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7757.457558] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7757.932244] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7758.107964] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 7771.377188] Lustre: Unmounted lustre-client [ 7771.386111] Lustre: Skipped 1 previous similar message [ 7811.654207] Key type lgssc unregistered [ 7811.895049] LNet: 153193:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7811.903780] LNetError: 153193:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7811.921257] LNet: Removed LNI 192.168.202.6@tcp [ 7812.873747] Key type .llcrypt unregistered [ 7812.875841] Key type ._llcrypt unregistered [ 7829.533221] Key type ._llcrypt registered [ 7829.535112] Key type .llcrypt registered [ 7831.168408] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 04:41:41 (1786696901) [ 7832.642228] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7832.724311] alg: No test for adler32 (adler32-zlib) [ 7833.919697] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 7834.247567] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 7836.015407] Key type lgssc registered [ 7837.019503] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7890.847933] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7896.318063] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7919.359318] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7943.312966] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7945.242635] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7946.529461] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 7952.413473] LustreError: lustre-MDT0001-mdc-ffff8d070675c000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7952.447097] Lustre: lustre-MDT0001-mdc-ffff8d070675c000: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [ 7959.100770] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7960.462133] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7985.702088] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7990.869673] Lustre: Unmounted lustre-client [ 8020.779705] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 04:44:51 (1786697091) [ 8122.779281] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8130.745957] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8157.251750] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8158.065118] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 8189.700952] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8191.607628] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8209.268953] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8219.682082] Lustre: Unmounted lustre-client [ 8257.583187] Key type lgssc unregistered [ 8257.938140] LNet: 162825:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8257.959306] LNetError: 162825:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8257.995843] LNet: Removed LNI 192.168.202.6@tcp [ 8259.019695] Key type .llcrypt unregistered [ 8259.025386] Key type ._llcrypt unregistered [ 8291.416551] Key type ._llcrypt registered [ 8291.417932] Key type .llcrypt registered [ 8293.260373] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 04:49:23 (1786697363) [ 8296.300394] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8296.309686] alg: No test for adler32 (adler32-zlib) [ 8297.345302] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 8297.595184] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 8299.295281] Key type lgssc registered [ 8301.388850] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8359.052234] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8366.306389] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8391.049608] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8394.090158] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 8442.765328] Lustre: Unmounted lustre-client [ 8487.615406] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8488.587957] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 8525.607104] Lustre: Unmounted lustre-client [ 8561.513610] Key type lgssc unregistered [ 8562.097718] LNet: 167284:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8562.113993] LNetError: 167284:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8562.146457] LNet: Removed LNI 192.168.202.6@tcp [ 8563.704765] Key type .llcrypt unregistered [ 8563.712547] Key type ._llcrypt unregistered [ 8585.063295] Key type ._llcrypt registered [ 8585.068590] Key type .llcrypt registered [ 8586.266786] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 04:54:17 (1786697657) [ 8589.596384] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8589.640216] alg: No test for adler32 (adler32-zlib) [ 8591.084594] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 8591.551960] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 8593.287267] Key type lgssc registered [ 8595.999289] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8662.259496] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8671.072767] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8698.181907] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8704.571810] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 8725.838121] Lustre: Unmounted lustre-client [ 8757.237551] Key type lgssc unregistered [ 8757.818071] LNet: 171047:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8757.826564] LNetError: 171047:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8757.874883] LNet: Removed LNI 192.168.202.6@tcp [ 8758.977442] Key type .llcrypt unregistered [ 8758.981806] Key type ._llcrypt unregistered [ 8774.472809] Key type ._llcrypt registered [ 8774.482210] Key type .llcrypt registered [ 8774.722494] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8774.739695] alg: No test for adler32 (adler32-zlib) [ 8776.115944] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 8776.330420] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 8777.975185] Key type lgssc registered [ 8779.416554] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8835.221608] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8841.515173] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8869.003578] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8880.181553] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 8890.575748] Lustre: Unmounted lustre-client [ 8920.254566] Key type lgssc unregistered [ 8920.580857] LNet: 174122:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8920.606351] LNetError: 174122:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8920.635726] LNet: Removed LNI 192.168.202.6@tcp [ 8921.697442] Key type .llcrypt unregistered [ 8921.705033] Key type ._llcrypt unregistered [ 8939.868912] Key type ._llcrypt registered [ 8939.876501] Key type .llcrypt registered [ 8941.915287] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 05:00:11 (1786698011) [ 8945.673343] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8945.739088] alg: No test for adler32 (adler32-zlib) [ 8946.848176] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 8947.170245] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 8948.839225] Key type lgssc registered [ 8950.574528] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9007.473634] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9013.456883] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9038.973971] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9040.760496] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 9063.513274] Lustre: Unmounted lustre-client [ 9094.135581] Key type lgssc unregistered [ 9094.447339] LNet: 177898:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9094.463592] LNetError: 177898:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9094.495296] LNet: Removed LNI 192.168.202.6@tcp [ 9095.261902] Key type .llcrypt unregistered [ 9095.268158] Key type ._llcrypt unregistered [ 9109.963423] Key type ._llcrypt registered [ 9109.969826] Key type .llcrypt registered [ 9110.740512] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9110.753895] alg: No test for adler32 (adler32-zlib) [ 9112.028485] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 9112.466252] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 9114.369456] Key type lgssc registered [ 9115.913604] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9176.283223] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9184.883661] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9212.384978] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9215.198556] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 9224.424077] Lustre: Unmounted lustre-client [ 9255.196145] Key type lgssc unregistered [ 9255.451899] LNet: 180972:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9255.478727] LNetError: 180972:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9255.503293] LNet: Removed LNI 192.168.202.6@tcp [ 9256.248777] Key type .llcrypt unregistered [ 9256.254285] Key type ._llcrypt unregistered [ 9275.252413] Key type ._llcrypt registered [ 9275.258648] Key type .llcrypt registered [ 9276.855671] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 05:05:47 (1786698347) [ 9300.509270] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9300.524094] alg: No test for adler32 (adler32-zlib) [ 9302.002948] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 9302.511861] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 9304.298796] Key type lgssc registered [ 9305.882226] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9404.610793] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9411.576896] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9441.464327] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9491.634725] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 05:09:22 (1786698562) [ 9532.956569] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9540.313678] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9567.250400] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9574.574803] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 9581.742311] Lustre: Unmounted lustre-client [ 9612.808882] Key type lgssc unregistered [ 9613.121244] LNet: 188092:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9613.138931] LNetError: 188092:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9613.156527] LNet: Removed LNI 192.168.202.6@tcp [ 9614.105661] Key type .llcrypt unregistered [ 9614.112314] Key type ._llcrypt unregistered [ 9632.288421] Key type ._llcrypt registered [ 9632.298627] Key type .llcrypt registered [ 9633.834766] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9635.975840] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 05:11:46 (1786698706) [ 9655.740371] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9655.766470] alg: No test for adler32 (adler32-zlib) [ 9656.809483] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [ 9657.045925] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [ 9658.799238] Key type lgssc registered [ 9660.149957] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9762.770885] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9769.842823] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9798.426646] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9822.214648] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9823.789525] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [ 9846.835171] Lustre: Unmounted lustre-client [ 9997.849633] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10004.738778] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10040.697436] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10088.916557] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 05:19:19 (1786699159) [10090.207340] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [10092.312304] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 05:19:23 (1786699163) [10188.658324] Key type lgssc unregistered [10189.019617] LNet: 199550:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10189.024399] LNetError: 199550:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10189.041410] LNet: Removed LNI 192.168.202.6@tcp [10189.761402] Key type .llcrypt unregistered [10189.767861] Key type ._llcrypt unregistered [10208.059258] Key type ._llcrypt registered [10208.061628] Key type .llcrypt registered [10209.538439] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 05:21:20 (1786699280) [10259.778785] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10259.990437] alg: No test for adler32 (adler32-zlib) [10261.228663] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [10261.703529] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [10263.448766] Key type lgssc registered [10265.382771] Lustre: Echo OBD driver; http://www.lustre.org/ [10324.778274] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10332.292519] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10368.685964] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10398.708968] Key type lgssc unregistered [10398.993870] LNet: 203291:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10398.998209] LNetError: 203291:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10399.026590] LNet: Removed LNI 192.168.202.6@tcp [10399.928597] Key type .llcrypt unregistered [10399.930803] Key type ._llcrypt unregistered [10416.994192] Key type ._llcrypt registered [10416.997447] Key type .llcrypt registered [10418.355833] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 05:24:49 (1786699489) [10421.428801] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10421.476962] alg: No test for adler32 (adler32-zlib) [10422.565239] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [10422.847133] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [10424.591355] Key type lgssc registered [10426.034243] Lustre: Echo OBD driver; http://www.lustre.org/ [10476.669585] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10482.962663] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10507.933927] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10510.609991] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [10521.065365] Lustre: lustre-MDT0000-mdc-ffff8d0711498800: Connection to lustre-MDT0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [10531.309222] Lustre: lustre-MDT0001-mdc-ffff8d0711498800: Connection to lustre-MDT0001 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [10542.559358] Lustre: 204281:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786699598/real 1786699598] req@00000000458db104 x1873490209751168/t0(0) o400->MGC192.168.202.106@tcp@192.168.202.106@tcp:26/25 lens 224/224 e 0 to 1 dl 1786699614 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10542.587327] LustreError: MGC192.168.202.106@tcp: Connection to MGS (at 192.168.202.106@tcp) was lost; in progress operations using this service will fail [10567.150742] Lustre: Evicted from MGS (at 192.168.202.106@tcp) after server handle changed from 0xaf8c23e5a43c2115 to 0xaf8c23e5a43c3c19 [10567.188677] Lustre: MGC192.168.202.106@tcp: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [10595.818849] LustreError: lustre-MDT0000-mdc-ffff8d0711498800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10595.855108] Lustre: lustre-MDT0000-mdc-ffff8d0711498800: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [10604.668155] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10607.416794] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10614.496968] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10616.821337] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10619.757189] Lustre: Unmounted lustre-client [10651.379369] Key type lgssc unregistered [10651.744279] LNet: 208248:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10651.752758] LNetError: 208248:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10651.762384] LNet: Removed LNI 192.168.202.6@tcp [10652.738561] Key type .llcrypt unregistered [10652.741127] Key type ._llcrypt unregistered [10674.966118] Key type ._llcrypt registered [10674.975129] Key type .llcrypt registered [10676.642606] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 05:29:07 (1786699747) [10679.870050] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10679.945496] alg: No test for adler32 (adler32-zlib) [10680.990624] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [10681.161986] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [10682.791193] Key type lgssc registered [10684.572229] Lustre: Echo OBD driver; http://www.lustre.org/ [10740.255134] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10746.482552] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10816.027187] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10822.430306] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10860.421737] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10884.611607] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10924.267945] Key type lgssc unregistered [10924.521782] LNet: 213549:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10924.537318] LNetError: 213549:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10924.555686] LNet: Removed LNI 192.168.202.6@tcp [10925.318110] Key type .llcrypt unregistered [10925.319724] Key type ._llcrypt unregistered [10969.407735] Key type ._llcrypt registered [10969.409194] Key type .llcrypt registered [10970.629848] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 05:34:01 (1786700041) [11008.358333] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11008.452975] alg: No test for adler32 (adler32-zlib) [11009.736309] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [11010.164762] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [11011.895264] Key type lgssc registered [11013.311171] Lustre: Echo OBD driver; http://www.lustre.org/ [11099.739750] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11106.006335] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11130.086510] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11173.900980] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 05:37:24 (1786700244) [11182.164383] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 05:37:33 (1786700253) [11217.154593] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11223.173258] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11244.492820] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11247.429686] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [11253.053136] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [11255.135556] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [11257.377412] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [11259.381614] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [11262.989221] Lustre: lustre-MDT0000-mdc-ffff8d0709b66000: Connection to lustre-MDT0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [11279.333429] Lustre: 215445:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786700335/real 1786700335] req@00000000d2bd9b6a x1873490825193088/t0(0) o400->MGC192.168.202.106@tcp@192.168.202.106@tcp:26/25 lens 224/224 e 0 to 1 dl 1786700351 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11279.369132] LustreError: MGC192.168.202.106@tcp: Connection to MGS (at 192.168.202.106@tcp) was lost; in progress operations using this service will fail [11288.562907] Lustre: lustre-MDT0000-mdc-ffff8d0709b66000: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [11289.601916] Lustre: Evicted from MGS (at 192.168.202.106@tcp) after server handle changed from 0x1cd831289f651dd9 to 0x1cd831289f6521de [11289.621504] Lustre: MGC192.168.202.106@tcp: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [11299.588123] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11301.172068] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11304.785167] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [11310.063771] Lustre: lustre-MDT0000-mdc-ffff8d0709b66000: Connection to lustre-MDT0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [11326.431390] Lustre: 215447:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786700382/real 1786700382] req@00000000d2b0af50 x1873490825201792/t0(0) o400->MGC192.168.202.106@tcp@192.168.202.106@tcp:26/25 lens 224/224 e 0 to 1 dl 1786700398 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11326.458253] LustreError: MGC192.168.202.106@tcp: Connection to MGS (at 192.168.202.106@tcp) was lost; in progress operations using this service will fail [11335.662583] Lustre: Evicted from MGS (at 192.168.202.106@tcp) after server handle changed from 0x1cd831289f6521de to 0x1cd831289f65228d [11335.684648] Lustre: MGC192.168.202.106@tcp: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [11341.253381] Lustre: lustre-MDT0000-mdc-ffff8d0709b66000: Connection restored to 192.168.202.106@tcp (at 192.168.202.106@tcp) [11352.326488] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11354.274746] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11358.204141] Lustre: Unmounted lustre-client [11429.286867] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11436.113551] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11458.918451] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11459.652822] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [11462.317361] Lustre: Unmounted lustre-client [11486.954458] Key type lgssc unregistered [11487.228399] LNet: 226026:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11487.239431] LNetError: 226026:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11487.263067] LNet: Removed LNI 192.168.202.6@tcp [11488.030237] Key type .llcrypt unregistered [11488.033430] Key type ._llcrypt unregistered [11505.528903] Key type ._llcrypt registered [11505.537459] Key type .llcrypt registered [11507.068850] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 05:42:57 (1786700577) [11511.700389] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11511.733657] alg: No test for adler32 (adler32-zlib) [11512.921960] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [11513.184823] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [11514.855277] Key type lgssc registered [11516.450385] Lustre: Echo OBD driver; http://www.lustre.org/ [11565.557237] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11571.093436] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11591.835984] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11593.868417] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [11602.823898] Lustre: Unmounted lustre-client [11683.302725] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11691.589706] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11716.603981] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11727.913692] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [11737.857532] Lustre: Unmounted lustre-client [11806.980034] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11812.760792] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11830.676452] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11831.447904] LustreError: 227012:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [11831.503662] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [11833.982828] Lustre: Unmounted lustre-client [11865.858368] Key type lgssc unregistered [11866.312420] LNet: 233074:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11866.338737] LNetError: 233074:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11866.381336] LNet: Removed LNI 192.168.202.6@tcp [11867.822664] Key type .llcrypt unregistered [11867.824359] Key type ._llcrypt unregistered [11887.823782] Key type ._llcrypt registered [11887.834134] Key type .llcrypt registered [11889.369340] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 05:49:20 (1786700960) [11893.635443] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11893.702989] alg: No test for adler32 (adler32-zlib) [11894.749614] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [11894.963181] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [11896.639533] Key type lgssc registered [11897.480498] Lustre: Echo OBD driver; http://www.lustre.org/ [11945.443504] Key type lgssc unregistered [11945.867599] LNet: 235399:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11945.877963] LNetError: 235399:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11945.896842] LNet: Removed LNI 192.168.202.6@tcp [11947.017392] Key type .llcrypt unregistered [11947.032439] Key type ._llcrypt unregistered [11979.225893] Key type ._llcrypt registered [11979.228374] Key type .llcrypt registered [11979.929590] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11980.003631] alg: No test for adler32 (adler32-zlib) [11981.154122] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [11981.423605] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [11983.112295] Key type lgssc registered [11984.696322] Lustre: Echo OBD driver; http://www.lustre.org/ [12072.436433] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12078.719183] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12103.404555] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12146.263639] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [12148.700454] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 05:53:39 (1786701219) [12190.630730] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12199.207118] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12221.175337] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12247.017455] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12249.130365] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [12254.210995] Lustre: lustre-OST0001-osc-ffff8d070a3b0000: Connection to lustre-OST0001 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [12264.281623] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12274.693739] Lustre: Unmounted lustre-client [12319.738709] Key type lgssc unregistered [12320.090922] LNet: 242524:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12320.118707] LNetError: 242524:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12320.144702] LNet: Removed LNI 192.168.202.6@tcp [12321.077898] Key type .llcrypt unregistered [12321.084702] Key type ._llcrypt unregistered [12354.923513] Key type ._llcrypt registered [12354.926798] Key type .llcrypt registered [12356.556646] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 05:57:07 (1786701427) [12371.296449] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12371.541133] alg: No test for adler32 (adler32-zlib) [12372.818186] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [12373.155160] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [12374.951318] Key type lgssc registered [12376.363512] Lustre: Echo OBD driver; http://www.lustre.org/ [12430.101833] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12438.145373] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12472.695812] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 05:59:02 (1786701542) [12518.672135] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12525.693764] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12553.437421] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12557.081326] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [12569.630486] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12579.497542] Lustre: Unmounted lustre-client [12691.906152] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12698.095347] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12752.517756] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12753.231558] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [12755.720496] Lustre: Unmounted lustre-client [12779.977446] Key type lgssc unregistered [12780.318500] LNet: 250258:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12780.329164] LNetError: 250258:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12780.346911] LNet: Removed LNI 192.168.202.6@tcp [12781.395231] Key type .llcrypt unregistered [12781.397228] Key type ._llcrypt unregistered [12813.060551] Key type ._llcrypt registered [12813.084218] Key type .llcrypt registered [12814.193764] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12814.229700] alg: No test for adler32 (adler32-zlib) [12815.449705] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [12815.835127] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [12817.623142] Key type lgssc registered [12819.284845] Lustre: Echo OBD driver; http://www.lustre.org/ [12902.201344] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12907.927695] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12936.567732] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12981.805974] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12983.081870] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 06:07:34 (1786702054) [13017.638270] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13023.697055] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13046.058790] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13052.214211] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [13057.300528] Lustre: Unmounted lustre-client [13084.865359] Key type lgssc unregistered [13085.066396] LNet: 256899:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13085.072503] LNetError: 256899:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13085.114627] LNet: Removed LNI 192.168.202.6@tcp [13086.124832] Key type .llcrypt unregistered [13086.132397] Key type ._llcrypt unregistered [13105.702959] Key type ._llcrypt registered [13105.708794] Key type .llcrypt registered [13107.138964] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [13108.961347] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 06:09:39 (1786702179) [13118.657138] Key type .llcrypt unregistered [13118.661200] Key type ._llcrypt unregistered [13130.541949] Key type ._llcrypt registered [13130.545616] Key type .llcrypt registered [13131.238391] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13131.247674] alg: No test for adler32 (adler32-zlib) [13132.753903] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [13133.162821] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [13134.911235] Key type lgssc registered [13136.610426] Lustre: Echo OBD driver; http://www.lustre.org/ [13195.086500] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13211.956608] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [13215.384612] Lustre: Unmounted lustre-client [13246.821932] Key type lgssc unregistered [13247.244306] LNet: 260369:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13247.260369] LNetError: 260369:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13247.291333] LNet: Removed LNI 192.168.202.6@tcp [13248.273164] Key type .llcrypt unregistered [13248.276266] Key type ._llcrypt unregistered [13267.985451] Key type ._llcrypt registered [13267.991044] Key type .llcrypt registered [13269.563881] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 06:12:20 (1786702340) [13272.530863] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13272.563899] alg: No test for adler32 (adler32-zlib) [13273.684047] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [13273.968957] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [13275.695589] Key type lgssc registered [13277.812606] Lustre: Echo OBD driver; http://www.lustre.org/ [13372.250110] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13414.408188] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13421.910991] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13424.768248] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [13427.708836] Lustre: Unmounted lustre-client [13452.298750] Key type lgssc unregistered [13452.677104] LNet: 263919:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13452.689930] LNetError: 263919:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13452.703840] LNet: Removed LNI 192.168.202.6@tcp [13453.522185] Key type .llcrypt unregistered [13453.526465] Key type ._llcrypt unregistered [13473.619651] Key type ._llcrypt registered [13473.630491] Key type .llcrypt registered [13474.850429] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 06:15:45 (1786702545) [13477.893338] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13478.023443] alg: No test for adler32 (adler32-zlib) [13479.265745] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [13479.608157] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [13481.447713] Key type lgssc registered [13482.808535] Lustre: Echo OBD driver; http://www.lustre.org/ [13539.127890] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13545.159522] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13569.354933] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13571.416301] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [13576.692757] Lustre: lustre-MDT0000-mdc-ffff8d070673d800: Connection to lustre-MDT0000 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [13579.453955] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13579.509326] LustreError: 267083:0:(file.c:6156:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13580.021780] LustreError: MGC192.168.202.106@tcp: Connection to MGS (at 192.168.202.106@tcp) was lost; in progress operations using this service will fail [13580.146078] Lustre: Unmounted lustre-client [13603.005769] Key type lgssc unregistered [13603.336103] LNet: 267500:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13603.354438] LNetError: 267500:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13603.379335] LNet: Removed LNI 192.168.202.6@tcp [13604.190102] Key type .llcrypt unregistered [13604.195852] Key type ._llcrypt unregistered [13623.153260] Key type ._llcrypt registered [13623.155634] Key type .llcrypt registered [13624.942909] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 06:18:15 (1786702695) [13628.328394] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13628.374935] alg: No test for adler32 (adler32-zlib) [13629.587829] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [13630.106487] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [13631.864551] Key type lgssc registered [13633.464906] Lustre: Echo OBD driver; http://www.lustre.org/ [13687.423341] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13692.627064] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13718.141965] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13721.143318] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [13726.205142] Lustre: lustre-MDT0001-mdc-ffff8d070ca3f800: Connection to lustre-MDT0001 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [13732.008348] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13734.940816] Lustre: Unmounted lustre-client [13756.260528] Key type lgssc unregistered [13756.577786] LNet: 271086:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13756.587869] LNetError: 271086:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13756.606892] LNet: Removed LNI 192.168.202.6@tcp [13757.445054] Key type .llcrypt unregistered [13757.452475] Key type ._llcrypt unregistered [13776.340555] Key type ._llcrypt registered [13776.346429] Key type .llcrypt registered [13778.508600] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 06:20:48 (1786702848) [13804.689276] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13804.717823] alg: No test for adler32 (adler32-zlib) [13806.021621] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [13806.391826] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [13808.176640] Key type lgssc registered [13809.853271] Lustre: Echo OBD driver; http://www.lustre.org/ [13940.292580] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13942.174139] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [13991.399792] Lustre: lustre-MDT0001-mdc-ffff8d0705923000: Connection to lustre-MDT0001 (at 192.168.202.106@tcp) was lost; in progress operations using this service will wait for recovery to complete [13998.969579] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [14009.376223] Lustre: Unmounted lustre-client [14053.736706] Key type lgssc unregistered [14054.025409] LNet: 276887:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14054.036712] LNetError: 276887:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14054.070486] LNet: Removed LNI 192.168.202.6@tcp [14055.025537] Key type .llcrypt unregistered [14055.027886] Key type ._llcrypt unregistered [14073.116689] Key type ._llcrypt registered [14073.124397] Key type .llcrypt registered [14074.576806] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 06:25:45 (1786703145) [14076.969676] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [14078.783083] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 06:25:49 (1786703149) [14080.543989] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [14082.063723] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 06:25:53 (1786703153) [14083.902605] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [14085.996872] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 06:25:56 (1786703156) [14087.805944] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [14090.208761] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 06:26:00 (1786703160) [14092.396756] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [14094.463911] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 06:26:05 (1786703165) [14106.676563] Key type .llcrypt unregistered [14106.687561] Key type ._llcrypt unregistered [14118.076412] Key type ._llcrypt registered [14118.078856] Key type .llcrypt registered [14118.887304] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14118.898811] alg: No test for adler32 (adler32-zlib) [14120.086490] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [14120.356245] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [14122.111225] Key type lgssc registered [14123.995689] Lustre: Echo OBD driver; http://www.lustre.org/ [14208.737112] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14214.150916] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14238.333711] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14240.160188] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [14245.463390] Lustre: Unmounted lustre-client [14287.911801] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 06:29:18 (1786703358) [14331.132447] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14338.398955] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14377.081981] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14377.750543] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [14381.021391] Lustre: Unmounted lustre-client [14426.358178] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 06:31:36 (1786703496) [14435.743391] LNet: 1 local NIs in recovery (showing 1): 192.168.202.6@tcp [15087.840328] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15096.168330] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15134.127961] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15243.846729] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 06:45:14 (1786704314) [15254.926593] Key type lgssc unregistered [15255.191492] LNet: 290434:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15255.202797] LNetError: 290434:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15255.228647] LNet: Removed LNI 192.168.202.6@tcp [15256.152671] Key type .llcrypt unregistered [15256.155627] Key type ._llcrypt unregistered [15382.571851] Key type ._llcrypt registered [15382.579337] Key type .llcrypt registered [15383.035269] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15383.064340] alg: No test for adler32 (adler32-zlib) [15384.492366] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [15384.925879] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [15386.601728] Key type lgssc registered [15388.277252] Lustre: Echo OBD driver; http://www.lustre.org/ [15488.489139] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15494.716601] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15520.366255] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15554.439938] Key type lgssc unregistered [15554.711867] LNet: 294143:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15554.721236] LNetError: 294143:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15554.737721] LNet: Removed LNI 192.168.202.6@tcp [15555.566797] Key type .llcrypt unregistered [15555.568706] Key type ._llcrypt unregistered [15595.271308] Key type ._llcrypt registered [15595.275277] Key type .llcrypt registered [15597.039541] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 06:51:07 (1786704667) [15623.110869] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15623.140783] alg: No test for adler32 (adler32-zlib) [15624.366034] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [15624.600514] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [15626.359355] Key type lgssc registered [15628.176200] Lustre: Echo OBD driver; http://www.lustre.org/ [15691.043779] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 06:52:41 (1786704761) [15706.776931] Key type lgssc unregistered [15706.947923] LNet: 297703:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15706.954390] LNetError: 297703:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15706.970637] LNet: Removed LNI 192.168.202.6@tcp [15707.726734] Key type .llcrypt unregistered [15707.730641] Key type ._llcrypt unregistered [15721.510825] Key type ._llcrypt registered [15721.555249] Key type .llcrypt registered [15721.994130] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15722.015072] alg: No test for adler32 (adler32-zlib) [15723.144269] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [15723.338860] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [15725.007192] Key type lgssc registered [15726.365992] Lustre: Echo OBD driver; http://www.lustre.org/ [15789.982941] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15797.051460] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15824.982843] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16128.351181] LNet: Added LNI 192.168.202.6@tcp50 [8/256/0/180] [16132.771701] LNet: Removed LNI 192.168.202.6@tcp [16135.246661] Lustre: 302105:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8d0704d1a800: config has no valid NIDs, force dynamic NIDs [16136.586746] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [16136.817572] Lustre: Unmounted lustre-client [16141.114299] Key type lgssc unregistered [16141.559696] LNet: 302369:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16141.564656] LNetError: 302369:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16141.580528] LNet: Removed LNI 192.168.202.6@tcp50 [16142.407980] Key type .llcrypt unregistered [16142.413531] Key type ._llcrypt unregistered [16171.683325] Key type ._llcrypt registered [16171.771823] Key type .llcrypt registered [16172.119216] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [16172.131788] alg: No test for adler32 (adler32-zlib) [16173.273695] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [16173.642262] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [16175.367322] Key type lgssc registered [16177.010590] Lustre: Echo OBD driver; http://www.lustre.org/ [16241.919317] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16248.413047] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16258.263277] LNet: Added LNI 192.168.202.6@tcp50 [8/256/0/180] [16259.216586] LNet: Removed LNI 192.168.202.6@tcp [16260.497092] Lustre: 305075:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8d070ca3b000: config has no valid NIDs, force dynamic NIDs [16262.019618] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [16262.675688] Lustre: Unmounted lustre-client [16305.724687] Key type lgssc unregistered [16306.061578] LNet: 305950:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16306.076943] LNetError: 305950:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16306.103962] LNet: Removed LNI 192.168.202.6@tcp50 [16306.884501] Key type .llcrypt unregistered [16306.889578] Key type ._llcrypt unregistered [16318.484547] Key type ._llcrypt registered [16318.490503] Key type .llcrypt registered [16319.828943] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 07:03:10 (1786705390) [16337.319069] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16337.335907] alg: No test for adler32 (adler32-zlib) [16338.558724] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [16338.860702] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [16340.567325] Key type lgssc registered [16341.717989] Lustre: Echo OBD driver; http://www.lustre.org/ [16430.618985] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16437.224762] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16464.702556] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16501.558051] Key type lgssc unregistered [16501.982700] LNet: 310702:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16501.989453] LNetError: 310702:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16502.019702] LNet: Removed LNI 192.168.202.6@tcp [16503.081085] Key type .llcrypt unregistered [16503.083982] Key type ._llcrypt unregistered [16519.475869] Key type ._llcrypt registered [16519.477971] Key type .llcrypt registered [16521.246149] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 07:06:31 (1786705591) [16524.377120] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16524.676700] alg: No test for adler32 (adler32-zlib) [16525.854893] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [16526.095349] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [16527.823407] Key type lgssc registered [16529.711699] Lustre: Echo OBD driver; http://www.lustre.org/ [16589.682432] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16597.432841] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16619.508704] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16631.891216] Lustre: Mounted lustre-client - version 2.17.57_1_g9a8e296 [16700.342697] Lustre: Mounted fs15246-client - version 2.17.57_1_g9a8e296 [16716.634242] Lustre: Unmounted fs15246-client [16746.353134] Lustre: Unmounted lustre-client [16776.505525] Key type lgssc unregistered [16776.745693] LNet: 315567:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16776.761201] LNetError: 315567:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16776.794359] LNet: Removed LNI 192.168.202.6@tcp [16777.762786] Key type .llcrypt unregistered [16777.765489] Key type ._llcrypt unregistered [16793.730805] Key type ._llcrypt registered [16793.738353] Key type .llcrypt registered [16795.707368] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 07:11:05 (1786705865) [16798.312084] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16798.378356] alg: No test for adler32 (adler32-zlib) [16799.756266] Lustre: Lustre: Build Version: 2.17.57_1_g9a8e296 [16800.101405] LNet: Added LNI 192.168.202.6@tcp [8/256/0/180] [16801.860245] Key type lgssc registered [16803.239166] Lustre: Echo OBD driver; http://www.lustre.org/ [16954.896793] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16962.620213] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16992.331958] Lustre: DEBUG MARKER: oleg206-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [17115.494695] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16867 sec ========= 07:16:26 (1786706186) [17117.091980] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 07:16:27 (1786706187) === [17120.478862] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 07:16:31 (1786706191) === [17155.541580] Key type lgssc unregistered [17155.782350] LNet: 324844:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17155.790563] LNetError: 324844:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17155.802597] LNet: Removed LNI 192.168.202.6@tcp [17156.399884] Key type .llcrypt unregistered [17156.402604] Key type ._llcrypt unregistered