[ 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 536416614 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, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.002320] x2apic enabled [ 0.003006] Switched APIC routing to physical x2apic. [ 0.004009] kvm-guest: setup PV IPIs [ 0.007432] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008018] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009009] pid_max: default: 32768 minimum: 301 [ 0.010000] LSM: Security Framework initializing [ 0.010043] Yama: becoming mindful. [ 0.011027] SELinux: Initializing. [ 0.011905] *** VALIDATE selinux *** [ 0.020677] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.025107] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.026145] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027108] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029072] *** VALIDATE tmpfs *** [ 0.030443] *** VALIDATE proc *** [ 0.031249] *** VALIDATE cgroup *** [ 0.033005] *** VALIDATE cgroup2 *** [ 0.034184] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035142] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038011] Spectre V2 : User space: Vulnerable [ 0.039010] Speculative Store Bypass: Vulnerable [ 0.042831] debug: unmapping init [mem 0xffffffff93859000-0xffffffff93860fff] [ 0.044164] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.045742] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.046021] ... version: 2 [ 0.047012] ... bit width: 48 [ 0.048011] ... generic registers: 4 [ 0.049008] ... value mask: 0000ffffffffffff [ 0.050012] ... max period: 00007fffffffffff [ 0.051021] ... fixed-purpose events: 3 [ 0.052011] ... event mask: 000000070000000f [ 0.053277] rcu: Hierarchical SRCU implementation. [ 0.055455] smp: Bringing up secondary CPUs ... [ 0.056540] x86: Booting SMP configuration: [ 0.057030] .... node #0, CPUs: #1 #2 #3 [ 0.065618] smp: Brought up 1 node, 4 CPUs [ 0.067014] smpboot: Max logical packages: 1 [ 0.068013] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.119055] node 0 deferred pages initialised in 49ms [ 0.122377] devtmpfs: initialized [ 0.124285] x86/mm: Memory block size: 128MB [ 0.127915] gcov: version magic: 0x41383552 [ 0.130284] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.134122] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.137396] pinctrl core: initialized pinctrl subsystem [ 0.138400] [ 0.140012] ************************************************************* [ 0.143017] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.145011] ** ** [ 0.148015] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.150011] ** ** [ 0.152012] ** This means that this kernel is built to expose internal ** [ 0.155013] ** IOMMU data structures, which may compromise security on ** [ 0.158012] ** your system. ** [ 0.160012] ** ** [ 0.163013] ** If you see this message and you are not debugging the ** [ 0.166013] ** kernel, report this immediately to your vendor! ** [ 0.169017] ** ** [ 0.171010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.174012] ************************************************************* [ 0.177383] NET: Registered protocol family 16 [ 0.179517] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.183068] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.186064] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.190136] cpuidle: using governor menu [ 0.192576] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.195577] PCI: Using configuration type 1 for base access [ 0.198146] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.207204] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.210039] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.214158] cryptd: max_cpu_qlen set to 1000 [ 0.217071] ACPI: Added _OSI(Module Device) [ 0.218012] ACPI: Added _OSI(Processor Device) [ 0.220014] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.222023] ACPI: Added _OSI(Processor Aggregator Device) [ 0.228423] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.234311] ACPI: Interpreter enabled [ 0.236058] ACPI: PM: (supports S0 S3 S4 S5) [ 0.238011] ACPI: Using IOAPIC for interrupt routing [ 0.240114] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.244505] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.255577] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.258037] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.261018] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.265131] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.271492] acpiphp: Slot [2] registered [ 0.273110] acpiphp: Slot [5] registered [ 0.275146] acpiphp: Slot [6] registered [ 0.277109] acpiphp: Slot [3] registered [ 0.279099] acpiphp: Slot [4] registered [ 0.281139] acpiphp: Slot [7] registered [ 0.282104] acpiphp: Slot [8] registered [ 0.284087] acpiphp: Slot [9] registered [ 0.286092] acpiphp: Slot [10] registered [ 0.288143] acpiphp: Slot [11] registered [ 0.289099] acpiphp: Slot [12] registered [ 0.291143] acpiphp: Slot [13] registered [ 0.293101] acpiphp: Slot [14] registered [ 0.295120] acpiphp: Slot [15] registered [ 0.296121] acpiphp: Slot [16] registered [ 0.298139] acpiphp: Slot [17] registered [ 0.300137] acpiphp: Slot [18] registered [ 0.302096] acpiphp: Slot [19] registered [ 0.304110] acpiphp: Slot [20] registered [ 0.306088] acpiphp: Slot [21] registered [ 0.307148] acpiphp: Slot [22] registered [ 0.309123] acpiphp: Slot [23] registered [ 0.311108] acpiphp: Slot [24] registered [ 0.313145] acpiphp: Slot [25] registered [ 0.315154] acpiphp: Slot [26] registered [ 0.316104] acpiphp: Slot [27] registered [ 0.318099] acpiphp: Slot [28] registered [ 0.320099] acpiphp: Slot [29] registered [ 0.322166] acpiphp: Slot [30] registered [ 0.324122] acpiphp: Slot [31] registered [ 0.326151] PCI host bridge to bus 0000:00 [ 0.327022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.330025] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.333054] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.336028] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.339026] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.343028] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.344276] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.348068] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.352368] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.359610] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.364097] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.367020] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.371020] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.373017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.375320] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.378734] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.381047] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.384760] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.389013] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.400768] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.405875] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.413278] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.432019] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.448017] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.502018] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.518616] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.528023] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.534019] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.553016] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.561732] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.564250] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.566290] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.567243] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.569126] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.572105] iommu: Default domain type: Passthrough [ 0.574429] SCSI subsystem initialized [ 0.576152] ACPI: bus type USB registered [ 0.577074] usbcore: registered new interface driver usbfs [ 0.578043] usbcore: registered new interface driver hub [ 0.580068] usbcore: registered new device driver usb [ 0.581120] pps_core: LinuxPPS API ver. 1 registered [ 0.582006] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.583047] PTP clock support registered [ 0.585086] EDAC MC: Ver: 3.0.0 [ 0.586260] PCI: Using ACPI for IRQ routing [ 0.587452] NetLabel: Initializing [ 0.588000] NetLabel: domain hash size = 128 [ 0.589012] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.590093] NetLabel: unlabeled traffic allowed by default [ 0.593003] vgaarb: loaded [ 0.594370] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.596013] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.603000] clocksource: Switched to clocksource kvm-clock [ 0.718774] VFS: Disk quotas dquot_6.6.0 [ 0.720322] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.722742] *** VALIDATE ramfs *** [ 0.723919] *** VALIDATE hugetlbfs *** [ 0.725471] pnp: PnP ACPI init [ 0.728440] pnp: PnP ACPI: found 6 devices [ 0.749516] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.752926] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.755154] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.757378] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.759739] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.762034] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.764114] NET: Registered protocol family 2 [ 0.766297] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.771158] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.774831] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.780187] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.783745] TCP: Hash tables configured (established 65536 bind 65536) [ 0.786622] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.789621] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.792533] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.795451] NET: Registered protocol family 1 [ 0.797781] RPC: Registered named UNIX socket transport module. [ 0.800132] RPC: Registered udp transport module. [ 0.801951] RPC: Registered tcp transport module. [ 0.803722] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.806394] NET: Registered protocol family 44 [ 0.807982] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.809808] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.811419] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.814850] PCI: CLS 0 bytes, default 64 [ 0.817101] Unpacking initramfs... [ 2.258572] debug: unmapping init [mem 0xffff91c57cc64000-0xffff91c57ffcffff] [ 2.262862] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.265334] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.268471] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.758595] Initialise system trusted keyrings [ 2.760125] Key type blacklist registered [ 2.762286] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.771564] zbud: loaded [ 2.774882] *** VALIDATE nfs *** [ 2.776262] *** VALIDATE nfs4 *** [ 2.778280] pstore: using deflate compression [ 2.782419] Platform Keyring initialized [ 2.897517] NET: Registered protocol family 38 [ 2.899318] Key type asymmetric registered [ 2.900503] Asymmetric key parser 'x509' registered [ 2.902198] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.904746] io scheduler mq-deadline registered [ 2.906649] io scheduler kyber registered [ 2.908566] io scheduler bfq registered [ 2.910230] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.912753] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.915160] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.917757] ACPI: Power Button [PWRF] [ 2.922416] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.928537] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.940121] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.966452] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.993809] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.999063] Non-volatile memory driver v1.3 [ 3.000848] Linux agpgart interface v0.103 [ 3.033191] virtio_blk virtio1: [vda] 147136 512-byte logical blocks (75.3 MB/71.8 MiB) [ 3.036473] vda: detected capacity change from 0 to 75333632 [ 3.051303] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.053576] vdb: detected capacity change from 0 to 1073741824 [ 3.058173] libphy: Fixed MDIO Bus: probed [ 3.068535] usbcore: registered new interface driver usbserial_generic [ 3.070637] usbserial: USB Serial support registered for generic [ 3.072769] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.077566] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.079413] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.081794] mousedev: PS/2 mouse device common for all mice [ 3.084692] rtc_cmos 00:05: RTC can wake from S4 [ 3.086820] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.091646] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.092670] rtc_cmos 00:05: registered as rtc0 [ 3.096469] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.098535] intel_pstate: CPU model not supported [ 3.100472] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.104591] hid: raw HID events driver (C) Jiri Kosina [ 3.106317] usbcore: registered new interface driver usbhid [ 3.107704] usbhid: USB HID core driver [ 3.109337] drop_monitor: Initializing network drop monitor service [ 3.111880] Initializing XFRM netlink socket [ 3.114021] NET: Registered protocol family 10 [ 3.118420] Segment Routing with IPv6 [ 3.119640] NET: Registered protocol family 17 [ 3.126240] mpls_gso: MPLS GSO support [ 3.137383] RAS: Correctable Errors collector initialized. [ 3.143177] AVX version of gcm_enc/dec engaged. [ 3.144703] AES CTR mode by8 optimization enabled [ 3.245624] sched_clock: Marking stable (3245535761, 0)->(4098862303, -853326542) [ 3.252364] registered taskstats version 1 [ 3.255380] Loading compiled-in X.509 certificates [ 3.259227] zswap: loaded using pool lzo/zbud [ 3.303181] Key type big_key registered [ 3.315210] Key type encrypted registered [ 3.316480] ima: No TPM chip found, activating TPM-bypass! [ 3.318708] ima: Allocated hash algorithm: sha1 [ 3.320633] ima: No architecture policies found [ 3.322378] evm: Initialising EVM extended attributes: [ 3.324410] evm: security.selinux [ 3.325630] evm: security.ima [ 3.326728] evm: security.capability [ 3.328056] evm: HMAC attrs: 0x1 [ 3.331182] rtc_cmos 00:05: setting system clock to 2026-09-11 14:04:35 UTC (1789135475) [ 3.338417] debug: unmapping init [mem 0xffffffff94803000-0xffffffff949fffff] [ 3.341167] debug: unmapping init [mem 0xffffffff93582000-0xffffffff93858fff] [ 3.350143] Write protecting the kernel read-only data: 28672k [ 3.353396] debug: unmapping init [mem 0xffffffff91c03000-0xffffffff91dfffff] [ 3.355832] debug: unmapping init [mem 0xffffffff92514000-0xffffffff925fffff] [ 3.393750] 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.401894] systemd[1]: Detected virtualization kvm. [ 3.403742] systemd[1]: Detected architecture x86-64. [ 3.405686] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.435609] systemd[1]: No hostname configured. [ 3.437909] systemd[1]: Set hostname to . [ 3.440654] random: systemd: uninitialized urandom read (16 bytes read) [ 3.443544] systemd[1]: Initializing machine ID from random generator. [ 3.595572] random: systemd: uninitialized urandom read (16 bytes read) [ 3.597983] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.603020] random: systemd: uninitialized urandom read (16 bytes read) [ 3.605812] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.610443] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Slices. [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket. Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Reached target Swap. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.221754] device-mapper: uevent: version 1.0.3 [ 4.223764] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.939852] virtio_net virtio0 ens2: renamed from eth0 [ 5.044302] scsi host0: ata_piix [ 5.062442] scsi host1: ata_piix [ 5.063925] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.065483] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.701627] dracut-initqueue[581]: RTNETLINK answers: File exists [ 9.833366] random: crng init done [ 9.834937] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.198765] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Sockets. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.328310] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.584986] SELinux: Disabled at runtime. [ 11.637211] 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.646692] systemd[1]: Detected virtualization kvm. [ 11.648617] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.140260] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.143392] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.148501] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.151745] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.154440] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.162444] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.167477] systemd[1]: proc-sys-fs-binfmt_misc.automount: Refusing to start, unit to trigger not loaded. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on Process Core Dump Socket. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. Mounting Huge Pages File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on udev Control Socket. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Stopped target Switch Root. [ OK ] Reached target RPC Port Mapper. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice User and Session Slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Reached target Paths. Mounting Kernel Debug File System... [ OK ] Stopped target Initrd File Systems. [ 12.289235] 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... [ OK ] Created slice system-getty.slice. [ OK ] Reached target Local Encrypted Volumes. Starting Apply Kernel Variables... [ OK ] Reached target Slices. [ OK ] Stopped target Initrd Root File System. Mounting POSIX Message Queue File System... [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.580532] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.889775] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.891604] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.022383] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.042532] EDAC sbridge: Ver: 1.1.2 [ 13.924129] Key type dns_resolver registered [ 14.220785] NFS: Registering the id_resolver key type [ 14.222749] Key type id_resolver registered [ 14.224436] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... [ OK ] Reached target sshd-keygen.target. [ OK ] Started irqbalance daemon. Starting Network Manager... Starting Restore /run/initramfs on shutdown... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ 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 Authorization Manager. [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg210-client login: [ 51.923311] libcfs: loading out-of-tree module taints kernel. [ 52.095168] Key type ._llcrypt registered [ 52.119703] Key type .llcrypt registered [ 53.032315] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 53.045939] alg: No test for adler32 (adler32-zlib) [ 54.780779] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 55.745234] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 57.623306] Key type lgssc registered [ 59.994060] Lustre: Echo OBD driver; http://www.lustre.org/ [ 123.499251] hrtimer: interrupt took 5240639 ns [ 262.347554] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 268.589309] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 285.711409] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing check_logdir /tmp/testlogs/ [ 288.224773] Lustre: lustre-OST0000-osc-ffff91c5c7a64000: disconnect after 23s idle [ 293.286611] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing yml_node [ 297.626899] Lustre: DEBUG MARKER: Client: 2.17.57.127 [ 300.244929] Lustre: DEBUG MARKER: MDS: 2.17.57.127 [ 302.727633] Lustre: DEBUG MARKER: OSS: 2.17.57.127 [ 304.448248] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Sep 11 10:09:35 EDT 2026 [ 323.020746] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 324.562376] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 328.151656] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 338.477701] Lustre: Unmounted lustre-client [ 454.272551] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 460.053423] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 483.657818] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 523.632713] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 10:13:13 (1789135993) [ 526.851559] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 528.894819] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 10:13:19 (1789135999) [ 565.899065] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 573.135086] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 598.183721] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 609.888324] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 615.068602] Lustre: Unmounted lustre-client [ 649.469162] Key type lgssc unregistered [ 649.817884] LNet: 15042:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 649.822739] LNetError: 15042:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 649.847914] LNet: Removed LNI 192.168.202.10@tcp [ 650.654210] Key type .llcrypt unregistered [ 650.656186] Key type ._llcrypt unregistered [ 667.489767] Key type ._llcrypt registered [ 667.492546] Key type .llcrypt registered [ 668.741784] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 10:15:39 (1789136139) [ 670.590491] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 670.658268] alg: No test for adler32 (adler32-zlib) [ 671.805168] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 672.070616] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 673.767199] Key type lgssc registered [ 675.430495] Lustre: Echo OBD driver; http://www.lustre.org/ [ 750.789711] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 834.138933] Lustre: Unmounted lustre-client [ 875.923989] Key type lgssc unregistered [ 876.158569] LNet: 18886:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 876.167787] LNetError: 18886:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 876.182624] LNet: Removed LNI 192.168.202.10@tcp [ 877.113512] Key type .llcrypt unregistered [ 877.115080] Key type ._llcrypt unregistered [ 890.025572] Key type ._llcrypt registered [ 890.027754] Key type .llcrypt registered [ 891.313813] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 10:19:21 (1789136361) [ 894.067416] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 894.306568] alg: No test for adler32 (adler32-zlib) [ 895.564057] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 895.922964] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 897.631243] Key type lgssc registered [ 899.312504] Lustre: Echo OBD driver; http://www.lustre.org/ [ 950.166108] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 956.637525] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 978.143411] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 980.894234] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 995.321505] Lustre: Unmounted lustre-client [ 1022.472533] Key type lgssc unregistered [ 1022.727415] LNet: 22486:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1022.740164] LNetError: 22486:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1023.783784] LNet: Removed LNI 192.168.202.10@tcp [ 1024.398485] Key type .llcrypt unregistered [ 1024.407310] Key type ._llcrypt unregistered [ 1038.615950] Key type ._llcrypt registered [ 1038.617300] Key type .llcrypt registered [ 1039.885681] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 10:21:50 (1789136510) [ 1043.097168] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1043.149092] alg: No test for adler32 (adler32-zlib) [ 1044.197420] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 1044.441808] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 1046.095600] Key type lgssc registered [ 1047.693754] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1098.240371] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1104.757057] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1129.482772] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1131.280962] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 1141.026955] Lustre: Unmounted lustre-client [ 1173.096682] Key type lgssc unregistered [ 1173.380623] LNet: 25675:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1173.386996] LNetError: 25675:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1173.409602] LNet: Removed LNI 192.168.202.10@tcp [ 1174.557374] Key type .llcrypt unregistered [ 1174.567514] Key type ._llcrypt unregistered [ 1191.215815] Key type ._llcrypt registered [ 1191.217898] Key type .llcrypt registered [ 1192.500754] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 10:24:23 (1789136663) [ 1195.099753] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1195.118952] alg: No test for adler32 (adler32-zlib) [ 1196.258205] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 1196.653238] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 1198.367334] Key type lgssc registered [ 1199.771746] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1258.700050] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1265.079875] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1287.446738] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1299.535577] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 1304.604556] Lustre: lustre-MDT0000-mdc-ffff91c5c56bd800: Connection to lustre-MDT0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1314.795815] Lustre: lustre-MDT0001-mdc-ffff91c5c56bd800: Connection to lustre-MDT0001 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1319.584030] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1325.024145] Lustre: 26637:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789136781/real 1789136781] req@000000006f41dac1 x1876045770791040/t0(0) o400->MGC192.168.202.110@tcp@192.168.202.110@tcp:26/25 lens 224/224 e 0 to 1 dl 1789136797 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1325.074122] LustreError: MGC192.168.202.110@tcp: Connection to MGS (at 192.168.202.110@tcp) was lost; in progress operations using this service will fail [ 1329.976124] Lustre: Unmounted lustre-client [ 1350.465766] Key type lgssc unregistered [ 1350.747854] LNet: 29334:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1350.766761] LNetError: 29334:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1350.793629] LNet: Removed LNI 192.168.202.10@tcp [ 1351.565079] Key type .llcrypt unregistered [ 1351.568160] Key type ._llcrypt unregistered [ 1368.078637] Key type ._llcrypt registered [ 1368.085965] Key type .llcrypt registered [ 1369.394714] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 10:27:20 (1789136840) [ 1372.557730] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1372.586087] alg: No test for adler32 (adler32-zlib) [ 1373.731875] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 1374.020338] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 1375.744324] Key type lgssc registered [ 1377.334197] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1433.527914] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1441.014216] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1464.077372] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1466.003124] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 1470.957096] Lustre: lustre-OST0000-osc-ffff91c5c957f000: Connection to lustre-OST0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1478.576619] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1488.986799] Lustre: Unmounted lustre-client [ 1518.704104] Key type lgssc unregistered [ 1519.047464] LNet: 32951:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1519.056750] LNetError: 32951:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1519.071149] LNet: Removed LNI 192.168.202.10@tcp [ 1519.862092] Key type .llcrypt unregistered [ 1519.872781] Key type ._llcrypt unregistered [ 1536.104490] Key type ._llcrypt registered [ 1536.108205] Key type .llcrypt registered [ 1537.305312] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 10:30:08 (1789137008) [ 1540.274283] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1540.340894] alg: No test for adler32 (adler32-zlib) [ 1541.358794] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 1541.617767] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 1543.359185] Key type lgssc registered [ 1544.907722] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1606.123772] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1612.620610] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1635.696749] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1638.558025] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 1642.571890] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1646.251678] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1657.797916] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-1110h32m08s [ 1660.295883] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1663.982134] Lustre: lustre-MDT0000-mdc-ffff91c5c9bcd800: Connection to lustre-MDT0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1671.249309] LustreError: 36739:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff91c5c9bcd800: can't stat MDS #0: rc = -19 [ 1673.038123] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1685.471281] Lustre: 33913:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789137141/real 1789137141] req@000000009c158623 x1876046132552320/t0(0) o400->MGC192.168.202.110@tcp@192.168.202.110@tcp:26/25 lens 224/224 e 0 to 1 dl 1789137157 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1685.511729] LustreError: MGC192.168.202.110@tcp: Connection to MGS (at 192.168.202.110@tcp) was lost; in progress operations using this service will fail [ 1685.539867] Lustre: Evicted from MGS (at 192.168.202.110@tcp) after server handle changed from 0xe34ffa5fe43cd691 to 0xe34ffa5fe43cd95b [ 1685.560538] Lustre: MGC192.168.202.110@tcp: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [ 1686.589489] LustreError: lustre-MDT0000-mdc-ffff91c5c9bcd800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1686.605416] Lustre: lustre-MDT0000-mdc-ffff91c5c9bcd800: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [ 1693.414812] Lustre: DEBUG MARKER: Wait for df (36739) ... [ 1696.351858] Lustre: DEBUG MARKER: done [ 1700.622287] Lustre: Unmounted lustre-client [ 1730.460855] Key type lgssc unregistered [ 1730.935835] LNet: 37761:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1730.953741] LNetError: 37761:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1730.986760] LNet: Removed LNI 192.168.202.10@tcp [ 1732.013100] Key type .llcrypt unregistered [ 1732.024372] Key type ._llcrypt unregistered [ 1767.441444] Key type ._llcrypt registered [ 1767.444686] Key type .llcrypt registered [ 1769.022536] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 10:33:59 (1789137239) [ 1771.666038] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1771.681752] alg: No test for adler32 (adler32-zlib) [ 1772.824536] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 1773.020696] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 1774.703236] Key type lgssc registered [ 1776.360689] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1830.286387] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1836.203317] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1857.726423] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1860.600357] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 1865.471889] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-1110h35m36s [ 1867.765574] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1875.703219] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1879.186139] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1900.000234] Lustre: 41914:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789137351/real 1789137351] req@00000000c23764d9 x1876046375819904/t0(0) o101->lustre-MDT0000-mdc-ffff91c5c5686800@192.168.202.110@tcp:12/10 lens 576/1152 e 0 to 1 dl 1789137371 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1900.055306] Lustre: lustre-MDT0000-mdc-ffff91c5c5686800: Connection to lustre-MDT0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1900.108709] Lustre: lustre-MDT0000-mdc-ffff91c5c5686800: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [ 1922.089732] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1926.073863] Lustre: DEBUG MARKER: done [ 1931.975956] Lustre: Unmounted lustre-client [ 1963.034546] Key type lgssc unregistered [ 1963.403492] LNet: 42796:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1963.409758] LNetError: 42796:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1963.422574] LNet: Removed LNI 192.168.202.10@tcp [ 1964.102315] Key type .llcrypt unregistered [ 1964.106925] Key type ._llcrypt unregistered [ 2000.623894] Key type ._llcrypt registered [ 2000.627033] Key type .llcrypt registered [ 2002.075383] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 10:37:52 (1789137472) [ 2004.142662] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2006.606505] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 10:37:56 (1789137476) [ 2010.901768] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2010.991092] alg: No test for adler32 (adler32-zlib) [ 2012.051922] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 2012.305236] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 2013.975350] Key type lgssc registered [ 2015.765296] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2047.024790] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 10:38:38 (1789137518) [ 2085.252321] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2092.310322] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2117.367261] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2119.658694] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 2123.747688] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2127.911306] Lustre: Unmounted lustre-client [ 2148.138561] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2198.399560] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2204.604754] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2205.208498] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 2208.891668] Lustre: Unmounted lustre-client [ 2273.185502] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2280.785713] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2281.838711] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 2285.331136] Lustre: Unmounted lustre-client [ 2316.516826] Lustre: DEBUG MARKER: files compared the same [ 2339.725433] Key type lgssc unregistered [ 2340.007374] LNet: 50426:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2340.031301] LNetError: 50426:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2340.058552] LNet: Removed LNI 192.168.202.10@tcp [ 2340.868413] Key type .llcrypt unregistered [ 2340.874428] Key type ._llcrypt unregistered [ 2358.481771] Key type ._llcrypt registered [ 2358.485194] Key type .llcrypt registered [ 2359.697558] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 10:43:50 (1789137830) [ 2362.003523] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2362.141600] alg: No test for adler32 (adler32-zlib) [ 2363.255762] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 2363.592256] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 2365.287204] Key type lgssc registered [ 2366.477098] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2419.848042] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2427.127414] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2453.162782] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2456.111344] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 2461.904129] Lustre: Unmounted lustre-client [ 2490.451311] Key type lgssc unregistered [ 2490.712929] LNet: 54016:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2490.719783] LNetError: 54016:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2491.749325] LNet: Removed LNI 192.168.202.10@tcp [ 2492.520987] Key type .llcrypt unregistered [ 2492.522436] Key type ._llcrypt unregistered [ 2508.955843] Key type ._llcrypt registered [ 2508.959280] Key type .llcrypt registered [ 2510.203823] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 10:46:20 (1789137980) [ 2513.505673] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2513.674274] alg: No test for adler32 (adler32-zlib) [ 2514.965255] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 2515.439260] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 2517.143200] Key type lgssc registered [ 2518.548927] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2607.878907] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2646.881052] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2653.972776] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2681.880344] Key type lgssc unregistered [ 2682.233488] LNet: 57507:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2682.238921] LNetError: 57507:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2682.254227] LNet: Removed LNI 192.168.202.10@tcp [ 2683.083587] Key type .llcrypt unregistered [ 2683.086800] Key type ._llcrypt unregistered [ 2697.832228] Key type ._llcrypt registered [ 2697.834533] Key type .llcrypt registered [ 2698.923887] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 10:49:29 (1789138169) [ 2702.340307] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2702.389488] alg: No test for adler32 (adler32-zlib) [ 2703.691033] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 2703.955231] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 2705.631984] Key type lgssc registered [ 2706.922473] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2782.075469] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 2789.952115] Lustre: Unmounted lustre-client [ 2829.564651] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 10:51:40 (1789138300) [ 2965.130599] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2982.016271] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 2990.505695] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2990.517801] LustreError: 63983:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff91c5c28d6800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2990.545844] Lustre: 58495:0:(llite_lib.c:4366:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.110@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3000.920660] Lustre: Unmounted lustre-client [ 3050.617863] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 10:55:21 (1789138521) [ 3065.090709] Key type lgssc unregistered [ 3065.498223] LNet: 65201:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3065.507518] LNetError: 65201:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3065.541747] LNet: Removed LNI 192.168.202.10@tcp [ 3066.552436] Key type .llcrypt unregistered [ 3066.557131] Key type ._llcrypt unregistered [ 3082.186673] Key type ._llcrypt registered [ 3082.190223] Key type .llcrypt registered [ 3082.779340] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3082.830361] alg: No test for adler32 (adler32-zlib) [ 3083.978920] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 3084.383849] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 3086.143342] Key type lgssc registered [ 3087.878409] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3152.252971] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3158.783243] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3185.141622] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3196.523141] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 3202.506276] Lustre: Unmounted lustre-client [ 3235.978060] Key type lgssc unregistered [ 3236.385986] LNet: 68221:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3236.394898] LNetError: 68221:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3236.428711] LNet: Removed LNI 192.168.202.10@tcp [ 3237.572623] Key type .llcrypt unregistered [ 3237.576703] Key type ._llcrypt unregistered [ 3252.704977] Key type ._llcrypt registered [ 3252.713529] Key type .llcrypt registered [ 3253.304158] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3253.334585] alg: No test for adler32 (adler32-zlib) [ 3254.492052] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 3254.850895] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 3256.679216] Key type lgssc registered [ 3258.711568] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3389.046303] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3395.966214] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3423.474112] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3430.515994] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 3434.373115] Lustre: Unmounted lustre-client [ 3467.651869] Key type lgssc unregistered [ 3468.027874] LNet: 71674:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3468.034757] LNetError: 71674:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3468.055749] LNet: Removed LNI 192.168.202.10@tcp [ 3468.751957] Key type .llcrypt unregistered [ 3468.754507] Key type ._llcrypt unregistered [ 3486.473350] Key type ._llcrypt registered [ 3486.475970] Key type .llcrypt registered [ 3488.029502] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 11:02:38 (1789138958) [ 3491.527590] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3491.555240] alg: No test for adler32 (adler32-zlib) [ 3492.673930] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 3492.925046] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 3494.599800] Key type lgssc registered [ 3496.088383] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3557.718642] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3564.202611] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3588.065441] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3595.387974] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 3602.800052] Lustre: Unmounted lustre-client [ 3603.297724] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 3606.494920] Lustre: Unmounted lustre-client [ 3636.899883] Key type lgssc unregistered [ 3637.330916] LNet: 75362:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3637.339688] LNetError: 75362:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3638.378865] LNet: Removed LNI 192.168.202.10@tcp [ 3639.212756] Key type .llcrypt unregistered [ 3639.214653] Key type ._llcrypt unregistered [ 3656.636637] Key type ._llcrypt registered [ 3656.638927] Key type .llcrypt registered [ 3657.172387] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3657.209769] alg: No test for adler32 (adler32-zlib) [ 3658.291855] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 3658.613708] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 3660.279294] Key type lgssc registered [ 3661.891806] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3721.532942] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3727.718952] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3749.975666] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3751.849899] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 3757.775554] Lustre: Unmounted lustre-client [ 3787.424824] Key type lgssc unregistered [ 3787.689973] LNet: 78398:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3787.696943] LNetError: 78398:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3787.733379] LNet: Removed LNI 192.168.202.10@tcp [ 3788.486758] Key type .llcrypt unregistered [ 3788.492204] Key type ._llcrypt unregistered [ 3804.126657] Key type ._llcrypt registered [ 3804.127923] Key type .llcrypt registered [ 3805.459940] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 11:07:56 (1789139276) [ 3808.100386] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3808.112638] alg: No test for adler32 (adler32-zlib) [ 3809.173430] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 3809.343675] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 3811.023245] Key type lgssc registered [ 3812.267876] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3870.756367] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3877.739921] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3902.778837] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3904.729757] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 3912.894087] Lustre: lustre: root_squash is set to 0:0 [ 3922.482324] Lustre: lustre: nosquash_nids is cleared [ 3922.533858] Lustre: lustre: root_squash is set to 500:500 [ 3928.177721] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.10@tcp 192.168.0.[2,10]@tcp [ 3944.953662] Lustre: lustre: nosquash_nids set to 192.168.202.10/24@tcp [ 3948.191228] Lustre: Unmounted lustre-client [ 3972.113813] Key type lgssc unregistered [ 3972.399054] LNet: 82354:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3972.405326] LNetError: 82354:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3972.424838] LNet: Removed LNI 192.168.202.10@tcp [ 3973.539151] Key type .llcrypt unregistered [ 3973.542232] Key type ._llcrypt unregistered [ 3992.540328] Key type ._llcrypt registered [ 3992.541733] Key type .llcrypt registered [ 3994.702278] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 11:11:04 (1789139464) [ 3997.073238] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3999.474836] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 11:11:10 (1789139470) [ 4003.457205] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4003.510675] alg: No test for adler32 (adler32-zlib) [ 4004.955787] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 4005.419565] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 4007.359156] Key type lgssc registered [ 4009.896182] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4066.760644] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4072.261951] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4093.056777] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4094.569573] Lustre: lustre: root_squash is set to 500:500 [ 4094.581400] Lustre: lustre: nosquash_nids set to 192.168.202.10/24@tcp [ 4095.746626] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 4104.661285] Lustre: Unmounted lustre-client [ 4132.258804] Key type lgssc unregistered [ 4132.614487] LNet: 86317:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4132.623918] LNetError: 86317:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4132.649742] LNet: Removed LNI 192.168.202.10@tcp [ 4133.356559] Key type .llcrypt unregistered [ 4133.361267] Key type ._llcrypt unregistered [ 4148.382646] Key type ._llcrypt registered [ 4148.388174] Key type .llcrypt registered [ 4149.582984] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4150.949413] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 11:13:42 (1789139622) [ 4169.073849] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4169.112758] alg: No test for adler32 (adler32-zlib) [ 4170.260908] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 4170.464862] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 4172.151166] Key type lgssc registered [ 4173.515330] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4257.237825] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4264.848697] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4290.702891] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4361.288731] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4367.695157] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4387.973599] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4399.348919] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 4438.314168] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff91c5d1834800.ost_server_uuid 50 [ 4440.331728] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff91c5d1834800.ost_server_uuid in IDLE state after 0 sec [ 4440.774956] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 4445.144455] Lustre: Unmounted lustre-client [ 4448.015131] Lustre: Unmounted lustre-client [ 4493.770471] Key type lgssc unregistered [ 4494.072259] LNet: 93979:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4494.082550] LNetError: 93979:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4494.106316] LNet: Removed LNI 192.168.202.10@tcp [ 4495.017382] Key type .llcrypt unregistered [ 4495.019828] Key type ._llcrypt unregistered [ 4525.876891] Key type ._llcrypt registered [ 4525.879626] Key type .llcrypt registered [ 4527.072891] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 11:19:57 (1789139997) [ 4546.302261] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4546.334585] alg: No test for adler32 (adler32-zlib) [ 4547.620576] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 4547.919924] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 4549.607134] Key type lgssc registered [ 4550.866571] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4635.625690] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4641.649263] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4670.081931] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4671.833528] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 4693.280866] Lustre: 95341:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789140149/real 1789140149] req@000000006a58e031 x1876049285616768/t0(0) o400->lustre-OST0000-osc-ffff91c5c4215800@192.168.202.110@tcp:28/4 lens 224/224 e 0 to 1 dl 1789140165 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4693.326113] Lustre: lustre-OST0000-osc-ffff91c5c4215800: Connection to lustre-OST0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4697.887491] Lustre: 95340:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789140154/real 1789140154] req@00000000cf14e939 x1876049285617280/t0(0) o400->lustre-OST0000-osc-ffff91c5c4215800@192.168.202.110@tcp:28/4 lens 224/224 e 0 to 1 dl 1789140170 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4703.713269] Lustre: 95340:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789140159/real 1789140159] req@00000000b45e0436 x1876049285617792/t0(0) o400->lustre-OST0000-osc-ffff91c5c4215800@192.168.202.110@tcp:28/4 lens 224/224 e 0 to 1 dl 1789140175 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4703.821439] Lustre: lustre-OST0000-osc-ffff91c5c4215800: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [ 4707.871609] Lustre: 95340:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789140164/real 1789140164] req@0000000083c5b68d x1876049285618304/t0(0) o400->lustre-OST0000-osc-ffff91c5c4215800@192.168.202.110@tcp:28/4 lens 224/224 e 0 to 1 dl 1789140180 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4708.839387] Lustre: lustre-MDT0000-mdc-ffff91c5c4215800: Connection to lustre-MDT0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4724.959787] Lustre: 95341:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789140181/real 1789140181] req@0000000004dde743 x1876049285620608/t0(0) o400->MGC192.168.202.110@tcp@192.168.202.110@tcp:26/25 lens 224/224 e 0 to 1 dl 1789140197 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4725.002963] LustreError: MGC192.168.202.110@tcp: Connection to MGS (at 192.168.202.110@tcp) was lost; in progress operations using this service will fail [ 4725.031207] Lustre: Evicted from MGS (at 192.168.202.110@tcp) after server handle changed from 0x8337c96bbfcf8e8f to 0x8337c96bbfcf9025 [ 4725.042742] Lustre: MGC192.168.202.110@tcp: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [ 4731.384492] Lustre: 98517:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.202.110@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 4739.516858] Lustre: lustre-MDT0000-mdc-ffff91c5c4215800: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [ 4745.468681] Lustre: Unmounted lustre-client [ 4773.975784] Key type lgssc unregistered [ 4774.278541] LNet: 99651:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4774.293435] LNetError: 99651:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4774.322404] LNet: Removed LNI 192.168.202.10@tcp [ 4775.113536] Key type .llcrypt unregistered [ 4775.118562] Key type ._llcrypt unregistered [ 4792.590564] Key type ._llcrypt registered [ 4792.593921] Key type .llcrypt registered [ 4794.495698] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 11:24:24 (1789140264) [ 4809.093491] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4809.165547] alg: No test for adler32 (adler32-zlib) [ 4810.422726] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 4810.702932] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 4812.479190] Key type lgssc registered [ 4813.861098] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4858.098449] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4971.355272] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4977.561532] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5003.926517] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5006.696564] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 5008.777398] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5011.550106] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 11:28:01 (1789140481) [ 5213.838585] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5224.156489] Lustre: Unmounted lustre-client [ 5362.364920] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5369.159818] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5394.121624] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5439.239952] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 11:35:10 (1789140910) [ 5539.715393] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5544.779785] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5568.346893] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5569.064502] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 5574.442314] Lustre: Unmounted lustre-client [ 5604.859696] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 11:37:55 (1789141075) [ 5709.101443] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5719.464156] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5744.551362] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5745.547102] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 5750.264645] Lustre: Unmounted lustre-client [ 5779.312420] Key type lgssc unregistered [ 5779.649979] LNet: 122683:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5779.657123] LNetError: 122683:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5779.693176] LNet: Removed LNI 192.168.202.10@tcp [ 5780.445206] Key type .llcrypt unregistered [ 5780.453061] Key type ._llcrypt unregistered [ 5796.962413] Key type ._llcrypt registered [ 5796.966453] Key type .llcrypt registered [ 5798.542497] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 11:41:08 (1789141268) [ 5801.432296] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5801.484152] alg: No test for adler32 (adler32-zlib) [ 5802.799225] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 5803.107417] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 5804.919468] Key type lgssc registered [ 5806.718647] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5868.936499] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5876.619126] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5900.607469] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5912.633168] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 5925.824868] Lustre: Unmounted lustre-client [ 5956.654653] Key type lgssc unregistered [ 5956.969532] LNet: 126283:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5956.979198] LNetError: 126283:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5957.016526] LNet: Removed LNI 192.168.202.10@tcp [ 5958.046809] Key type .llcrypt unregistered [ 5958.049541] Key type ._llcrypt unregistered [ 5976.220782] Key type ._llcrypt registered [ 5976.222960] Key type .llcrypt registered [ 5977.436641] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 11:44:08 (1789141448) [ 5980.041502] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5980.065190] alg: No test for adler32 (adler32-zlib) [ 5981.217165] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 5981.477946] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 5983.159195] Key type lgssc registered [ 5984.475666] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6041.752515] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6048.229420] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6072.719319] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6084.162739] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 6089.201661] Lustre: lustre-OST0000-osc-ffff91c5c6ef2000: Connection to lustre-OST0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6101.908668] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff91c5c6ef2000.ost_server_uuid 50 [ 6103.405376] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6115.122315] Lustre: Unmounted lustre-client [ 6138.191325] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 11:46:48 (1789141608) [ 6175.050241] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6181.102530] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6205.465063] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6231.297568] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6232.203483] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 6237.681481] Lustre: lustre-OST0000-osc-ffff91c5d019b000: Connection to lustre-OST0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6268.020540] Lustre: Unmounted lustre-client [ 6319.432528] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 11:49:50 (1789141790) [ 6354.536551] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6360.699391] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6384.518997] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6407.675037] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6408.359082] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 6413.822577] Lustre: lustre-OST0000-osc-ffff91c5c8493000: Connection to lustre-OST0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6431.169335] Lustre: Unmounted lustre-client [ 6491.392933] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 11:52:42 (1789141962) [ 6599.235583] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6607.540947] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6636.034832] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6712.195122] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6718.805099] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6744.499576] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6780.703812] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 6824.058865] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6827.212133] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 1 sec [ 6830.092358] Lustre: Unmounted lustre-client [ 6881.163761] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 11:59:12 (1789142352) [ 6916.520290] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6922.534695] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6945.935668] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6985.250498] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7018.543864] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 7062.369942] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7063.864385] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7084.276239] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7094.642816] Lustre: Unmounted lustre-client [ 7162.724993] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 12:03:52 (1789142632) [ 7201.510488] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7207.935239] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7232.053920] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7232.682924] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 7260.173854] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7262.174427] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7277.658368] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff91c5d608a000.ost_server_uuid 50 [ 7279.894406] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff91c5d608a000.ost_server_uuid in IDLE state after 0 sec [ 7284.520307] Lustre: Unmounted lustre-client [ 7285.002304] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7285.020608] Lustre: Skipped 3 previous similar messages [ 7285.145048] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 7286.393121] LustreError: 149734:0:(sec.c:403:import_sec_validate_get()) import 0000000071472457 (NEW) with no sec [ 7359.632894] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 12:07:09 (1789142829) [ 7397.464869] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7403.924612] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7423.513996] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7441.116692] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7441.593263] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7441.695170] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 7455.057451] Lustre: Unmounted lustre-client [ 7455.060246] Lustre: Skipped 1 previous similar message [ 7490.467266] Key type lgssc unregistered [ 7490.728282] LNet: 153161:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7490.733150] LNetError: 153161:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7490.753105] LNet: Removed LNI 192.168.202.10@tcp [ 7491.367880] Key type .llcrypt unregistered [ 7491.373117] Key type ._llcrypt unregistered [ 7508.243373] Key type ._llcrypt registered [ 7508.245590] Key type .llcrypt registered [ 7509.758372] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 12:09:40 (1789142980) [ 7511.063247] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7511.131284] alg: No test for adler32 (adler32-zlib) [ 7512.304453] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 7512.643572] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 7514.407243] Key type lgssc registered [ 7515.570399] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7568.252273] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7574.421438] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7594.688758] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7613.631609] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7615.311315] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7616.483496] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 7623.198616] LustreError: lustre-MDT0001-mdc-ffff91c5d1056800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7623.226730] Lustre: lustre-MDT0001-mdc-ffff91c5d1056800: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [ 7628.965904] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7630.803561] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7655.434565] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7661.194876] Lustre: Unmounted lustre-client [ 7691.870834] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 12:12:42 (1789143162) [ 7789.479797] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7794.659600] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7820.136590] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7820.650057] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 7845.883033] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7847.563684] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7852.525892] Lustre: lustre-OST0001-osc-ffff91c5c418a000: Connection to lustre-OST0001 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7859.851560] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7870.203790] Lustre: Unmounted lustre-client [ 7915.253457] Key type lgssc unregistered [ 7915.560550] LNet: 162783:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7915.569537] LNetError: 162783:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7915.585693] LNet: Removed LNI 192.168.202.10@tcp [ 7916.457182] Key type .llcrypt unregistered [ 7916.459236] Key type ._llcrypt unregistered [ 7951.275340] Key type ._llcrypt registered [ 7951.277918] Key type .llcrypt registered [ 7952.947569] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 12:17:03 (1789143423) [ 7955.535550] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7955.550026] alg: No test for adler32 (adler32-zlib) [ 7956.675109] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 7956.880479] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 7958.552516] Key type lgssc registered [ 7959.959958] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8015.749792] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8021.391317] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8044.215591] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8047.012870] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 8093.553613] Lustre: Unmounted lustre-client [ 8137.635179] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8138.506522] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 8175.194538] Lustre: Unmounted lustre-client [ 8205.741905] Key type lgssc unregistered [ 8206.003941] LNet: 167235:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8206.022403] LNetError: 167235:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8207.091033] LNet: Removed LNI 192.168.202.10@tcp [ 8208.267799] Key type .llcrypt unregistered [ 8208.269944] Key type ._llcrypt unregistered [ 8225.545529] Key type ._llcrypt registered [ 8225.547500] Key type .llcrypt registered [ 8226.666391] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 12:21:37 (1789143697) [ 8229.693043] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8229.808539] alg: No test for adler32 (adler32-zlib) [ 8230.999792] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 8231.449312] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 8233.224091] Key type lgssc registered [ 8234.801319] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8297.518488] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8302.591788] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8325.435912] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8328.093786] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 8349.038384] Lustre: Unmounted lustre-client [ 8391.327862] Key type lgssc unregistered [ 8391.780333] LNet: 170993:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8391.799472] LNetError: 170993:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8391.827742] LNet: Removed LNI 192.168.202.10@tcp [ 8392.670720] Key type .llcrypt unregistered [ 8392.679348] Key type ._llcrypt unregistered [ 8406.849869] Key type ._llcrypt registered [ 8406.866194] Key type .llcrypt registered [ 8407.228893] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8407.249826] alg: No test for adler32 (adler32-zlib) [ 8408.341561] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 8408.594939] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 8410.375307] Key type lgssc registered [ 8411.950528] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8472.874448] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8478.619981] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8502.851482] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8504.715676] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 8514.135940] Lustre: Unmounted lustre-client [ 8544.922939] Key type lgssc unregistered [ 8545.328876] LNet: 174059:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8545.336649] LNetError: 174059:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8545.365654] LNet: Removed LNI 192.168.202.10@tcp [ 8546.548264] Key type .llcrypt unregistered [ 8546.554728] Key type ._llcrypt unregistered [ 8570.129648] Key type ._llcrypt registered [ 8570.131182] Key type .llcrypt registered [ 8572.092229] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 12:27:21 (1789144041) [ 8575.125942] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8575.142208] alg: No test for adler32 (adler32-zlib) [ 8576.326282] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 8576.583758] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 8578.287185] Key type lgssc registered [ 8579.755296] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8630.158744] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8636.035931] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8656.200313] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8657.739271] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 8680.210717] Lustre: Unmounted lustre-client [ 8710.058649] Key type lgssc unregistered [ 8710.246903] LNet: 177819:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8710.257668] LNetError: 177819:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8711.273975] LNet: Removed LNI 192.168.202.10@tcp [ 8711.912732] Key type .llcrypt unregistered [ 8711.915405] Key type ._llcrypt unregistered [ 8722.956761] Key type ._llcrypt registered [ 8722.959875] Key type .llcrypt registered [ 8723.389285] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8723.418645] alg: No test for adler32 (adler32-zlib) [ 8724.399971] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 8724.622942] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 8726.375637] Key type lgssc registered [ 8727.743558] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8777.832878] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8785.452544] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8808.524842] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8810.109277] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 8816.393310] Lustre: Unmounted lustre-client [ 8840.146107] Key type lgssc unregistered [ 8840.375880] LNet: 180880:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8840.384261] LNetError: 180880:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8840.409369] LNet: Removed LNI 192.168.202.10@tcp [ 8841.029653] Key type .llcrypt unregistered [ 8841.030931] Key type ._llcrypt unregistered [ 8857.279761] Key type ._llcrypt registered [ 8857.282292] Key type .llcrypt registered [ 8858.487865] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 12:32:09 (1789144329) [ 8879.747734] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8879.814459] alg: No test for adler32 (adler32-zlib) [ 8880.883415] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 8881.126639] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 8882.791271] Key type lgssc registered [ 8884.153976] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8964.803734] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8969.841215] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8994.139648] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9038.048802] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 12:35:07 (1789144507) [ 9073.111500] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9079.486732] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9101.670518] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9104.310406] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 9112.978829] Lustre: Unmounted lustre-client [ 9143.668560] Key type lgssc unregistered [ 9143.987138] LNet: 187982:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9143.995136] LNetError: 187982:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9144.036682] LNet: Removed LNI 192.168.202.10@tcp [ 9144.832786] Key type .llcrypt unregistered [ 9144.835184] Key type ._llcrypt unregistered [ 9161.066967] Key type ._llcrypt registered [ 9161.070768] Key type .llcrypt registered [ 9162.206981] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9163.822900] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 12:37:14 (1789144634) [ 9182.548385] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9182.742101] alg: No test for adler32 (adler32-zlib) [ 9184.041116] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 9184.347825] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 9186.023261] Key type lgssc registered [ 9187.347760] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9287.130568] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9294.621752] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9321.742592] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9346.093638] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9348.836354] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [ 9372.807517] Lustre: Unmounted lustre-client [ 9506.480940] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9510.994309] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9532.795208] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9578.727685] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 12:44:08 (1789145048) [ 9581.012749] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9582.685100] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 12:44:13 (1789145053) [ 9677.528888] Key type lgssc unregistered [ 9677.748168] LNet: 199424:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9677.762413] LNetError: 199424:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9677.787551] LNet: Removed LNI 192.168.202.10@tcp [ 9678.537115] Key type .llcrypt unregistered [ 9678.538911] Key type ._llcrypt unregistered [ 9695.339787] Key type ._llcrypt registered [ 9695.340889] Key type .llcrypt registered [ 9696.427687] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 12:46:07 (1789145167) [ 9737.062408] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9737.153068] alg: No test for adler32 (adler32-zlib) [ 9738.244719] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 9738.459953] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 9740.113902] Key type lgssc registered [ 9741.321172] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9786.054779] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9791.171100] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9827.208473] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9859.133715] Key type lgssc unregistered [ 9859.810678] LNet: 203157:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9859.827134] LNetError: 203157:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9859.913313] LNet: Removed LNI 192.168.202.10@tcp [ 9861.430299] Key type .llcrypt unregistered [ 9861.433174] Key type ._llcrypt unregistered [ 9884.297141] Key type ._llcrypt registered [ 9884.305478] Key type .llcrypt registered [ 9886.320187] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 12:49:16 (1789145356) [ 9890.185578] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9890.251531] alg: No test for adler32 (adler32-zlib) [ 9891.284886] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [ 9891.494940] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [ 9893.232639] Key type lgssc registered [ 9895.161483] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9950.698220] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9957.539534] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9982.063945] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9993.257285] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [10003.435953] Lustre: lustre-MDT0000-mdc-ffff91c5c6946000: Connection to lustre-MDT0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [10019.814819] Lustre: 204151:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789145475/real 1789145475] req@00000000e85f32ad x1876054888235008/t0(0) o400->MGC192.168.202.110@tcp@192.168.202.110@tcp:26/25 lens 224/224 e 0 to 1 dl 1789145491 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10019.851433] LustreError: MGC192.168.202.110@tcp: Connection to MGS (at 192.168.202.110@tcp) was lost; in progress operations using this service will fail [10023.967166] Lustre: 204149:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789145480/real 1789145480] req@000000006af76f24 x1876054888235904/t0(0) o400->lustre-MDT0001-mdc-ffff91c5c6946000@192.168.202.110@tcp:12/10 lens 224/224 e 0 to 1 dl 1789145496 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10024.010467] Lustre: lustre-MDT0001-mdc-ffff91c5c6946000: Connection to lustre-MDT0001 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [10029.024372] Lustre: 204151:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789145485/real 1789145485] req@0000000035ece17b x1876054888236288/t0(0) o400->lustre-MDT0001-mdc-ffff91c5c6946000@192.168.202.110@tcp:12/10 lens 224/224 e 0 to 1 dl 1789145501 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10030.205600] Lustre: Evicted from MGS (at 192.168.202.110@tcp) after server handle changed from 0x2cdc747f59472778 to 0x2cdc747f594742de [10030.228679] Lustre: MGC192.168.202.110@tcp: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [10034.639182] Lustre: 204149:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789145490/real 1789145490] req@000000001ca830c1 x1876054888236672/t0(0) o400->lustre-MDT0001-mdc-ffff91c5c6946000@192.168.202.110@tcp:12/10 lens 224/224 e 0 to 1 dl 1789145506 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10039.264822] Lustre: 204150:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789145495/real 1789145495] req@000000004a604c7c x1876054888237184/t0(0) o400->lustre-MDT0001-mdc-ffff91c5c6946000@192.168.202.110@tcp:12/10 lens 224/224 e 0 to 1 dl 1789145511 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10039.294903] Lustre: 204150:0:(client.c:2503:ptlrpc_expire_one_request()) Skipped 1 previous similar message [10047.980152] LustreError: lustre-MDT0000-mdc-ffff91c5c6946000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10048.062441] Lustre: lustre-MDT0000-mdc-ffff91c5c6946000: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [10055.528249] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10057.647160] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10064.289670] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10066.871815] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10071.221058] Lustre: Unmounted lustre-client [10106.296711] Key type lgssc unregistered [10106.670994] LNet: 208111:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10106.679502] LNetError: 208111:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10106.704156] LNet: Removed LNI 192.168.202.10@tcp [10107.569943] Key type .llcrypt unregistered [10107.572075] Key type ._llcrypt unregistered [10127.124810] Key type ._llcrypt registered [10127.127060] Key type .llcrypt registered [10128.448875] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 12:53:19 (1789145599) [10131.154050] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10131.179799] alg: No test for adler32 (adler32-zlib) [10132.234939] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [10132.422892] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [10134.088245] Key type lgssc registered [10135.329917] Lustre: Echo OBD driver; http://www.lustre.org/ [10186.891396] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10192.841114] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10253.458791] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10259.293590] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10294.681949] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10317.093086] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10356.070810] Key type lgssc unregistered [10356.434745] LNet: 213408:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10356.446476] LNetError: 213408:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10356.467689] LNet: Removed LNI 192.168.202.10@tcp [10357.215716] Key type .llcrypt unregistered [10357.217981] Key type ._llcrypt unregistered [10403.565289] Key type ._llcrypt registered [10403.569235] Key type .llcrypt registered [10405.112358] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 12:57:55 (1789145875) [10450.305847] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10450.321835] alg: No test for adler32 (adler32-zlib) [10451.352799] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [10451.586873] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [10453.337533] Key type lgssc registered [10454.623123] Lustre: Echo OBD driver; http://www.lustre.org/ [10538.083973] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10543.327377] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10563.592319] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10610.466236] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 13:01:21 (1789146081) [10617.420587] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 13:01:28 (1789146088) [10654.143359] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10660.122839] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10682.070811] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10683.800672] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [10692.422810] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10694.154634] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10695.571764] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10697.126259] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10699.246307] Lustre: lustre-MDT0000-mdc-ffff91c5c28d2000: Connection to lustre-MDT0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [10715.620593] Lustre: 215305:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789146171/real 1789146171] req@00000000b7b99f57 x1876055475365376/t0(0) o400->MGC192.168.202.110@tcp@192.168.202.110@tcp:26/25 lens 224/224 e 0 to 1 dl 1789146187 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10715.638146] LustreError: MGC192.168.202.110@tcp: Connection to MGS (at 192.168.202.110@tcp) was lost; in progress operations using this service will fail [10724.860758] Lustre: Evicted from MGS (at 192.168.202.110@tcp) after server handle changed from 0x89a1784fe0ed279d to 0x89a1784fe0ed2917 [10724.891347] Lustre: MGC192.168.202.110@tcp: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [10732.490466] Lustre: lustre-MDT0000-mdc-ffff91c5c28d2000: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [10742.022529] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10743.539733] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10746.711832] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10750.441381] Lustre: lustre-MDT0000-mdc-ffff91c5c28d2000: Connection to lustre-MDT0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [10766.815843] Lustre: 215308:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789146222/real 1789146222] req@00000000e17fd43f x1876055475374464/t0(0) o400->MGC192.168.202.110@tcp@192.168.202.110@tcp:26/25 lens 224/224 e 0 to 1 dl 1789146238 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10766.844444] LustreError: MGC192.168.202.110@tcp: Connection to MGS (at 192.168.202.110@tcp) was lost; in progress operations using this service will fail [10766.879050] Lustre: Evicted from MGS (at 192.168.202.110@tcp) after server handle changed from 0x89a1784fe0ed2917 to 0x89a1784fe0ed2cd6 [10766.892790] Lustre: MGC192.168.202.110@tcp: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [10772.432518] Lustre: lustre-MDT0000-mdc-ffff91c5c28d2000: Connection restored to 192.168.202.110@tcp (at 192.168.202.110@tcp) [10780.557906] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10782.478558] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10786.942647] Lustre: Unmounted lustre-client [10861.801583] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10868.641981] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10891.626762] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10892.277866] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [10900.774657] Lustre: Unmounted lustre-client [10925.910196] Key type lgssc unregistered [10926.172955] LNet: 225899:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10926.195446] LNetError: 225899:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10926.223344] LNet: Removed LNI 192.168.202.10@tcp [10927.221924] Key type .llcrypt unregistered [10927.226823] Key type ._llcrypt unregistered [10944.412185] Key type ._llcrypt registered [10944.414188] Key type .llcrypt registered [10945.617674] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 13:06:56 (1789146416) [10949.684308] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10949.734896] alg: No test for adler32 (adler32-zlib) [10950.892424] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [10951.228919] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [10952.903805] Key type lgssc registered [10954.462555] Lustre: Echo OBD driver; http://www.lustre.org/ [11005.540151] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11011.009819] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11031.809615] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11034.488994] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [11040.416239] Lustre: Unmounted lustre-client [11104.537281] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11111.245863] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11132.254743] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11133.044092] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [11141.746158] Lustre: Unmounted lustre-client [11210.981904] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11216.875629] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11236.454861] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11236.901149] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [11238.116690] Lustre: Unmounted lustre-client [11270.571253] Key type lgssc unregistered [11270.823635] LNet: 232952:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11270.831545] LNetError: 232952:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11271.851759] LNet: Removed LNI 192.168.202.10@tcp [11272.411971] Key type .llcrypt unregistered [11272.414216] Key type ._llcrypt unregistered [11288.227716] Key type ._llcrypt registered [11288.229844] Key type .llcrypt registered [11289.355298] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 13:12:40 (1789146760) [11292.132579] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11292.153817] alg: No test for adler32 (adler32-zlib) [11293.387571] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [11293.568174] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [11295.231205] Key type lgssc registered [11296.177769] Lustre: Echo OBD driver; http://www.lustre.org/ [11333.239500] Key type lgssc unregistered [11333.519665] LNet: 235275:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11333.528398] LNetError: 235275:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11333.553093] LNet: Removed LNI 192.168.202.10@tcp [11334.512596] Key type .llcrypt unregistered [11334.514206] Key type ._llcrypt unregistered [11364.959711] Key type ._llcrypt registered [11364.970680] Key type .llcrypt registered [11365.260927] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11365.273201] alg: No test for adler32 (adler32-zlib) [11366.481106] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [11366.759892] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [11368.399202] Key type lgssc registered [11369.531178] Lustre: Echo OBD driver; http://www.lustre.org/ [11446.047029] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11451.361149] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11473.452532] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11517.600777] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11519.413194] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 13:16:30 (1789146990) [11553.295395] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11560.150930] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11583.305874] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11605.457801] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11606.909798] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [11612.141328] Lustre: lustre-OST0001-osc-ffff91c5c28d3000: Connection to lustre-OST0001 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [11620.947631] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11631.303136] Lustre: Unmounted lustre-client [11674.336798] Key type lgssc unregistered [11674.634620] LNet: 242391:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11674.656629] LNetError: 242391:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11674.685100] LNet: Removed LNI 192.168.202.10@tcp [11675.390577] Key type .llcrypt unregistered [11675.394900] Key type ._llcrypt unregistered [11703.446495] Key type ._llcrypt registered [11703.451126] Key type .llcrypt registered [11705.011446] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 13:19:35 (1789147175) [11719.065973] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11719.154149] alg: No test for adler32 (adler32-zlib) [11720.294616] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [11720.624214] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [11722.399205] Key type lgssc registered [11724.067965] Lustre: Echo OBD driver; http://www.lustre.org/ [11775.391466] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11780.646522] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11804.078339] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 13:21:14 (1789147274) [11837.153474] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11842.193585] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11861.756365] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11864.303721] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [11878.408424] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11881.938221] Lustre: Unmounted lustre-client [11981.977570] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11987.545667] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12043.719130] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12044.524858] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [12047.763666] Lustre: Unmounted lustre-client [12079.982597] Key type lgssc unregistered [12080.228367] LNet: 250093:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12080.232250] LNetError: 250093:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12080.265595] LNet: Removed LNI 192.168.202.10@tcp [12081.218557] Key type .llcrypt unregistered [12081.225156] Key type ._llcrypt unregistered [12110.274104] Key type ._llcrypt registered [12110.295843] Key type .llcrypt registered [12110.866155] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12110.888993] alg: No test for adler32 (adler32-zlib) [12112.049703] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [12112.457031] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [12114.272103] Key type lgssc registered [12115.721543] Lustre: Echo OBD driver; http://www.lustre.org/ [12204.543345] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12210.698697] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12236.655585] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12296.636650] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12298.442812] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 13:29:29 (1789147769) [12336.020974] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12343.555070] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12371.638630] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12381.245131] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [12386.003912] Lustre: Unmounted lustre-client [12416.949711] Key type lgssc unregistered [12417.193696] LNet: 256743:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12417.203227] LNetError: 256743:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12417.233082] LNet: Removed LNI 192.168.202.10@tcp [12418.055124] Key type .llcrypt unregistered [12418.057913] Key type ._llcrypt unregistered [12440.389410] Key type ._llcrypt registered [12440.396918] Key type .llcrypt registered [12442.516142] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12445.058851] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 13:31:55 (1789147915) [12455.645297] Key type .llcrypt unregistered [12455.647953] Key type ._llcrypt unregistered [12467.379494] Key type ._llcrypt registered [12467.381539] Key type .llcrypt registered [12467.760917] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12467.780648] alg: No test for adler32 (adler32-zlib) [12468.917755] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [12469.248238] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [12470.935224] Key type lgssc registered [12472.387646] Lustre: Echo OBD driver; http://www.lustre.org/ [12536.598741] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12557.485682] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [12560.762035] Lustre: Unmounted lustre-client [12598.174677] Key type lgssc unregistered [12598.437946] LNet: 260213:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12598.456781] LNetError: 260213:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12599.525880] LNet: Removed LNI 192.168.202.10@tcp [12600.623843] Key type .llcrypt unregistered [12600.633446] Key type ._llcrypt unregistered [12619.272460] Key type ._llcrypt registered [12619.275578] Key type .llcrypt registered [12621.242933] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 13:34:51 (1789148091) [12624.090578] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12624.109977] alg: No test for adler32 (adler32-zlib) [12625.374038] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [12625.625367] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [12627.280255] Key type lgssc registered [12628.776605] Lustre: Echo OBD driver; http://www.lustre.org/ [12712.824816] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12747.270990] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12752.664222] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12755.268965] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [12758.635540] Lustre: Unmounted lustre-client [12789.108759] Key type lgssc unregistered [12789.494331] LNet: 263761:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12789.514865] LNetError: 263761:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12789.555594] LNet: Removed LNI 192.168.202.10@tcp [12790.345117] Key type .llcrypt unregistered [12790.350419] Key type ._llcrypt unregistered [12809.365533] Key type ._llcrypt registered [12809.368198] Key type .llcrypt registered [12810.751747] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 13:38:01 (1789148281) [12812.826688] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12812.844205] alg: No test for adler32 (adler32-zlib) [12813.833651] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [12814.013344] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [12815.681244] Key type lgssc registered [12817.171338] Lustre: Echo OBD driver; http://www.lustre.org/ [12871.800385] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12877.602755] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12896.358592] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12898.023686] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [12903.404333] Lustre: lustre-MDT0000-mdc-ffff91c5c65b9000: Connection to lustre-MDT0000 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [12909.143303] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12909.204242] LustreError: 266914:0:(file.c:6184:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12909.725981] LustreError: MGC192.168.202.110@tcp: Connection to MGS (at 192.168.202.110@tcp) was lost; in progress operations using this service will fail [12909.766411] Lustre: Unmounted lustre-client [12933.235617] Key type lgssc unregistered [12933.608588] LNet: 267330:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12933.618792] LNetError: 267330:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12933.643982] LNet: Removed LNI 192.168.202.10@tcp [12934.610823] Key type .llcrypt unregistered [12934.617259] Key type ._llcrypt unregistered [12949.993644] Key type ._llcrypt registered [12949.996030] Key type .llcrypt registered [12951.024926] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 13:40:22 (1789148422) [12953.578591] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12953.638102] alg: No test for adler32 (adler32-zlib) [12954.792704] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [12955.137791] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [12956.879819] Key type lgssc registered [12958.204638] Lustre: Echo OBD driver; http://www.lustre.org/ [13011.704496] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13018.117714] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13039.566095] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13042.601094] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [13053.218824] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13055.345279] Lustre: Unmounted lustre-client [13077.370665] Key type lgssc unregistered [13077.650549] LNet: 270916:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13077.657738] LNetError: 270916:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13077.699561] LNet: Removed LNI 192.168.202.10@tcp [13078.443129] Key type .llcrypt unregistered [13078.452438] Key type ._llcrypt unregistered [13094.516463] Key type ._llcrypt registered [13094.520230] Key type .llcrypt registered [13096.002028] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 13:42:46 (1789148566) [13116.167908] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13116.199873] alg: No test for adler32 (adler32-zlib) [13117.460989] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [13117.657099] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [13119.320603] Key type lgssc registered [13121.031380] Lustre: Echo OBD driver; http://www.lustre.org/ [13247.391079] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13250.262884] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [13292.008239] Lustre: lustre-MDT0001-mdc-ffff91c5c56bd000: Connection to lustre-MDT0001 (at 192.168.202.110@tcp) was lost; in progress operations using this service will wait for recovery to complete [13302.304198] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13312.612270] Lustre: Unmounted lustre-client [13339.426236] Key type lgssc unregistered [13339.698801] LNet: 276707:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13339.706378] LNetError: 276707:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13339.724692] LNet: Removed LNI 192.168.202.10@tcp [13340.663722] Key type .llcrypt unregistered [13340.665895] Key type ._llcrypt unregistered [13358.629668] Key type ._llcrypt registered [13358.631934] Key type .llcrypt registered [13359.855738] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 13:47:10 (1789148830) [13361.306642] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13362.874247] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 13:47:13 (1789148833) [13364.550671] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13366.947752] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 13:47:17 (1789148837) [13369.291605] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13370.959777] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 13:47:21 (1789148841) [13372.239323] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13374.391938] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 13:47:24 (1789148844) [13376.045852] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13377.834583] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 13:47:28 (1789148848) [13387.171327] Key type .llcrypt unregistered [13387.172965] Key type ._llcrypt unregistered [13394.855886] Key type ._llcrypt registered [13394.862633] Key type .llcrypt registered [13395.394610] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13395.408629] alg: No test for adler32 (adler32-zlib) [13396.530389] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [13396.754608] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [13398.455201] Key type lgssc registered [13399.838568] Lustre: Echo OBD driver; http://www.lustre.org/ [13484.463558] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13491.753235] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13517.916843] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13519.884691] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [13523.749718] Lustre: Unmounted lustre-client [13563.593368] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 13:50:34 (1789149034) [13600.172631] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13606.267431] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13641.610106] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13647.408654] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [13649.763015] Lustre: Unmounted lustre-client [13695.739233] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 13:52:46 (1789149166) [13698.847357] LNet: 1 local NIs in recovery (showing 1): 192.168.202.10@tcp [14342.391492] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14348.157070] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14384.350780] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14500.956510] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 14:06:11 (1789149971) [14510.550982] Key type lgssc unregistered [14510.783630] LNet: 290252:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14510.799738] LNetError: 290252:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14511.846510] LNet: Removed LNI 192.168.202.10@tcp [14512.649603] Key type .llcrypt unregistered [14512.651432] Key type ._llcrypt unregistered [14634.609065] Key type ._llcrypt registered [14634.616244] Key type .llcrypt registered [14635.119698] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14635.135195] alg: No test for adler32 (adler32-zlib) [14636.260290] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [14636.442988] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [14638.109411] Key type lgssc registered [14639.471541] Lustre: Echo OBD driver; http://www.lustre.org/ [14729.316777] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14735.515502] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14760.139951] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14813.605302] Key type lgssc unregistered [14814.019008] LNet: 293953:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14814.034868] LNetError: 293953:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14814.056662] LNet: Removed LNI 192.168.202.10@tcp [14815.169967] Key type .llcrypt unregistered [14815.175590] Key type ._llcrypt unregistered [14854.017141] Key type ._llcrypt registered [14854.018785] Key type .llcrypt registered [14856.595641] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 14:12:05 (1789150325) [14880.057121] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14880.103157] alg: No test for adler32 (adler32-zlib) [14881.171802] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [14881.503391] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [14883.183194] Key type lgssc registered [14884.732680] Lustre: Echo OBD driver; http://www.lustre.org/ [14946.698120] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 14:13:37 (1789150417) [14960.675424] Key type lgssc unregistered [14961.110700] LNet: 297516:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14961.118136] LNetError: 297516:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14961.130167] LNet: Removed LNI 192.168.202.10@tcp [14962.185885] Key type .llcrypt unregistered [14962.187684] Key type ._llcrypt unregistered [14974.724508] Key type ._llcrypt registered [14974.739139] Key type .llcrypt registered [14975.017735] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14975.029427] alg: No test for adler32 (adler32-zlib) [14976.032455] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [14976.504485] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [14978.447338] Key type lgssc registered [14980.657558] Lustre: Echo OBD driver; http://www.lustre.org/ [15046.195723] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15051.444985] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15076.131500] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15391.314965] LNet: Added LNI 192.168.202.10@tcp50 [8/256/0/180] [15393.741536] LNet: Removed LNI 192.168.202.10@tcp [15395.978506] Lustre: 301920:0:(ldlm_lib.c:599:client_obd_setup()) lustre-MDT0000-mdc-ffff91c5c4192800: config has no valid NIDs, force dynamic NIDs [15397.236537] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [15397.372840] Lustre: Unmounted lustre-client [15399.876365] Key type lgssc unregistered [15400.191618] LNet: 302182:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15400.201943] LNetError: 302182:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15400.228939] LNet: Removed LNI 192.168.202.10@tcp50 [15400.930450] Key type .llcrypt unregistered [15400.933445] Key type ._llcrypt unregistered [15419.176566] Key type ._llcrypt registered [15419.192367] Key type .llcrypt registered [15419.663926] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15419.680581] alg: No test for adler32 (adler32-zlib) [15420.688584] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [15420.932147] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [15422.559197] Key type lgssc registered [15423.689264] Lustre: Echo OBD driver; http://www.lustre.org/ [15486.440409] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15492.837933] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15499.934580] LNet: Added LNI 192.168.202.10@tcp50 [8/256/0/180] [15500.868704] LNet: Removed LNI 192.168.202.10@tcp [15502.095542] Lustre: 304876:0:(ldlm_lib.c:599:client_obd_setup()) lustre-MDT0000-mdc-ffff91c5d10c2800: config has no valid NIDs, force dynamic NIDs [15503.344262] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [15503.864840] Lustre: Unmounted lustre-client [15537.858816] Key type lgssc unregistered [15538.164089] LNet: 305749:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15538.169232] LNetError: 305749:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15538.185382] LNet: Removed LNI 192.168.202.10@tcp50 [15538.755596] Key type .llcrypt unregistered [15538.759463] Key type ._llcrypt unregistered [15553.700444] Key type ._llcrypt registered [15553.705191] Key type .llcrypt registered [15555.847617] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 14:23:45 (1789151025) [15579.964249] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15580.320116] alg: No test for adler32 (adler32-zlib) [15581.586969] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [15581.898471] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [15583.551250] Key type lgssc registered [15584.963623] Lustre: Echo OBD driver; http://www.lustre.org/ [15682.453951] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15688.031993] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15715.305692] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15748.317967] Key type lgssc unregistered [15748.671795] LNet: 310502:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15748.685406] LNetError: 310502:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15748.722218] LNet: Removed LNI 192.168.202.10@tcp [15749.575939] Key type .llcrypt unregistered [15749.580205] Key type ._llcrypt unregistered [15762.703445] Key type ._llcrypt registered [15762.706647] Key type .llcrypt registered [15763.844190] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 14:27:14 (1789151234) [15766.926528] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15767.000592] alg: No test for adler32 (adler32-zlib) [15768.150882] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [15768.420833] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [15770.127758] Key type lgssc registered [15771.585861] Lustre: Echo OBD driver; http://www.lustre.org/ [15825.487560] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15830.777767] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15853.982442] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15856.625794] Lustre: Mounted lustre-client - version 2.17.57_127_ged01a19 [15915.202515] Lustre: Mounted fs15246-client - version 2.17.57_127_ged01a19 [15928.563348] Lustre: Unmounted fs15246-client [15955.967651] Lustre: Unmounted lustre-client [15987.587962] Key type lgssc unregistered [15987.985260] LNet: 315365:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15988.005709] LNetError: 315365:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15988.034222] LNet: Removed LNI 192.168.202.10@tcp [15989.246428] Key type .llcrypt unregistered [15989.249453] Key type ._llcrypt unregistered [16005.687348] Key type ._llcrypt registered [16005.692908] Key type .llcrypt registered [16007.502690] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 14:31:17 (1789151477) [16009.898888] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16009.961836] alg: No test for adler32 (adler32-zlib) [16010.960354] Lustre: Lustre: Build Version: 2.17.57_127_ged01a19 [16011.137547] LNet: Added LNI 192.168.202.10@tcp [8/256/0/180] [16012.887205] Key type lgssc registered [16014.524913] Lustre: Echo OBD driver; http://www.lustre.org/ [16142.726679] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16148.703286] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16172.929143] Lustre: DEBUG MARKER: oleg210-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16277.530461] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15972 sec ========= 14:35:48 (1789151748) [16278.972041] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 14:35:49 (1789151749) === [16281.838554] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 14:35:52 (1789151752) === [16314.542529] Key type lgssc unregistered [16314.829822] LNet: 324633:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16314.841552] LNetError: 324633:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16314.864056] LNet: Removed LNI 192.168.202.10@tcp [16315.632565] Key type .llcrypt unregistered [16315.637459] Key type ._llcrypt unregistered