[ 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 512972887 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.002339] x2apic enabled [ 0.003006] Switched APIC routing to physical x2apic. [ 0.004010] kvm-guest: setup PV IPIs [ 0.006777] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007017] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008007] pid_max: default: 32768 minimum: 301 [ 0.009117] LSM: Security Framework initializing [ 0.010035] Yama: becoming mindful. [ 0.011023] SELinux: Initializing. [ 0.012048] *** VALIDATE selinux *** [ 0.020039] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.025079] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.026133] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027092] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028113] *** VALIDATE tmpfs *** [ 0.030207] *** VALIDATE proc *** [ 0.031226] *** VALIDATE cgroup *** [ 0.032006] *** VALIDATE cgroup2 *** [ 0.033234] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035006] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036005] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037025] Spectre V2 : User space: Vulnerable [ 0.038006] Speculative Store Bypass: Vulnerable [ 0.041362] debug: unmapping init [mem 0xffffffffaee59000-0xffffffffaee60fff] [ 0.043788] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044656] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045017] ... version: 2 [ 0.046014] ... bit width: 48 [ 0.047007] ... generic registers: 4 [ 0.048013] ... value mask: 0000ffffffffffff [ 0.049007] ... max period: 00007fffffffffff [ 0.050008] ... fixed-purpose events: 3 [ 0.051011] ... event mask: 000000070000000f [ 0.052274] rcu: Hierarchical SRCU implementation. [ 0.054243] smp: Bringing up secondary CPUs ... [ 0.055508] x86: Booting SMP configuration: [ 0.056027] .... node #0, CPUs: #1 #2 #3 [ 0.066068] smp: Brought up 1 node, 4 CPUs [ 0.068009] smpboot: Max logical packages: 1 [ 0.069013] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.097595] node 0 deferred pages initialised in 27ms [ 0.101030] devtmpfs: initialized [ 0.102192] x86/mm: Memory block size: 128MB [ 0.104086] gcov: version magic: 0x41383552 [ 0.107231] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.108073] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.110255] pinctrl core: initialized pinctrl subsystem [ 0.112123] [ 0.112569] ************************************************************* [ 0.115009] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.117007] ** ** [ 0.119009] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.121008] ** ** [ 0.123011] ** This means that this kernel is built to expose internal ** [ 0.126009] ** IOMMU data structures, which may compromise security on ** [ 0.128007] ** your system. ** [ 0.130009] ** ** [ 0.132008] ** If you see this message and you are not debugging the ** [ 0.134009] ** kernel, report this immediately to your vendor! ** [ 0.136007] ** ** [ 0.138012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.140008] ************************************************************* [ 0.142608] NET: Registered protocol family 16 [ 0.144391] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.147067] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.149048] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.153021] cpuidle: using governor menu [ 0.155311] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.157358] PCI: Using configuration type 1 for base access [ 0.159121] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.170101] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.172018] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.176061] cryptd: max_cpu_qlen set to 1000 [ 0.180240] ACPI: Added _OSI(Module Device) [ 0.182013] ACPI: Added _OSI(Processor Device) [ 0.184011] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.185009] ACPI: Added _OSI(Processor Aggregator Device) [ 0.190611] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.196613] ACPI: Interpreter enabled [ 0.198055] ACPI: PM: (supports S0 S3 S4 S5) [ 0.200011] ACPI: Using IOAPIC for interrupt routing [ 0.202082] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.205403] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.215947] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.218034] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.222018] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.226079] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.232356] acpiphp: Slot [2] registered [ 0.234100] acpiphp: Slot [5] registered [ 0.236083] acpiphp: Slot [6] registered [ 0.238109] acpiphp: Slot [3] registered [ 0.239068] acpiphp: Slot [4] registered [ 0.241078] acpiphp: Slot [7] registered [ 0.242068] acpiphp: Slot [8] registered [ 0.243057] acpiphp: Slot [9] registered [ 0.244067] acpiphp: Slot [10] registered [ 0.245076] acpiphp: Slot [11] registered [ 0.246054] acpiphp: Slot [12] registered [ 0.247056] acpiphp: Slot [13] registered [ 0.248060] acpiphp: Slot [14] registered [ 0.249057] acpiphp: Slot [15] registered [ 0.250059] acpiphp: Slot [16] registered [ 0.251078] acpiphp: Slot [17] registered [ 0.252061] acpiphp: Slot [18] registered [ 0.253054] acpiphp: Slot [19] registered [ 0.254057] acpiphp: Slot [20] registered [ 0.255058] acpiphp: Slot [21] registered [ 0.256063] acpiphp: Slot [22] registered [ 0.257063] acpiphp: Slot [23] registered [ 0.259077] acpiphp: Slot [24] registered [ 0.260055] acpiphp: Slot [25] registered [ 0.261055] acpiphp: Slot [26] registered [ 0.262055] acpiphp: Slot [27] registered [ 0.263059] acpiphp: Slot [28] registered [ 0.264056] acpiphp: Slot [29] registered [ 0.265081] acpiphp: Slot [30] registered [ 0.266056] acpiphp: Slot [31] registered [ 0.267065] PCI host bridge to bus 0000:00 [ 0.268017] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.270011] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.272014] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.273011] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.275012] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.277038] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.279145] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.280849] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.284019] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.292012] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.295523] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.299016] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.301011] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.303012] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.305526] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.307702] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.310075] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.313690] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.316822] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.325011] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.330010] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.334898] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.590013] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.603012] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.648011] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.660665] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.673013] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.687012] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.715011] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.731000] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.734257] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.736263] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.737236] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.739202] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.743052] iommu: Default domain type: Passthrough [ 0.744355] SCSI subsystem initialized [ 0.745121] ACPI: bus type USB registered [ 0.746127] usbcore: registered new interface driver usbfs [ 0.749076] usbcore: registered new interface driver hub [ 0.751057] usbcore: registered new device driver usb [ 0.754140] pps_core: LinuxPPS API ver. 1 registered [ 0.756008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.760049] PTP clock support registered [ 0.763040] EDAC MC: Ver: 3.0.0 [ 0.764478] PCI: Using ACPI for IRQ routing [ 0.766698] NetLabel: Initializing [ 0.768008] NetLabel: domain hash size = 128 [ 0.770006] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.771106] NetLabel: unlabeled traffic allowed by default [ 0.774082] vgaarb: loaded [ 0.776217] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.778010] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.786347] clocksource: Switched to clocksource kvm-clock [ 0.881818] VFS: Disk quotas dquot_6.6.0 [ 0.883042] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.886506] *** VALIDATE ramfs *** [ 0.887390] *** VALIDATE hugetlbfs *** [ 0.888826] pnp: PnP ACPI init [ 0.890867] pnp: PnP ACPI: found 6 devices [ 0.963795] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.967731] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.969917] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.972574] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.974605] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.975880] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.977475] NET: Registered protocol family 2 [ 0.979114] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.982558] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.985599] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.989339] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.991869] TCP: Hash tables configured (established 65536 bind 65536) [ 0.993887] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.995678] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.997435] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.999243] NET: Registered protocol family 1 [ 1.002702] RPC: Registered named UNIX socket transport module. [ 1.004267] RPC: Registered udp transport module. [ 1.006170] RPC: Registered tcp transport module. [ 1.007278] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.008584] NET: Registered protocol family 44 [ 1.009481] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.010628] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.011776] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.013033] PCI: CLS 0 bytes, default 64 [ 1.013961] Unpacking initramfs... [ 2.388771] debug: unmapping init [mem 0xffff8a027cc64000-0xffff8a027ffcffff] [ 2.392640] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.395096] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.398159] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.907226] Initialise system trusted keyrings [ 2.908968] Key type blacklist registered [ 2.910707] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.919475] zbud: loaded [ 2.922619] *** VALIDATE nfs *** [ 2.924256] *** VALIDATE nfs4 *** [ 2.926191] pstore: using deflate compression [ 2.930327] Platform Keyring initialized [ 3.086448] NET: Registered protocol family 38 [ 3.088093] Key type asymmetric registered [ 3.089676] Asymmetric key parser 'x509' registered [ 3.091489] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.094721] io scheduler mq-deadline registered [ 3.098969] io scheduler kyber registered [ 3.100504] io scheduler bfq registered [ 3.103241] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.106780] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.110302] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.113865] ACPI: Power Button [PWRF] [ 3.119578] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.125725] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.160467] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.189372] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.220029] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.228441] Non-volatile memory driver v1.3 [ 3.230067] Linux agpgart interface v0.103 [ 3.262467] virtio_blk virtio1: [vda] 145888 512-byte logical blocks (74.7 MB/71.2 MiB) [ 3.265440] vda: detected capacity change from 0 to 74694656 [ 3.287600] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.291031] vdb: detected capacity change from 0 to 1073741824 [ 3.300879] libphy: Fixed MDIO Bus: probed [ 3.305863] usbcore: registered new interface driver usbserial_generic [ 3.308421] usbserial: USB Serial support registered for generic [ 3.310976] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.315632] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.317667] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.320470] mousedev: PS/2 mouse device common for all mice [ 3.323091] rtc_cmos 00:05: RTC can wake from S4 [ 3.327051] rtc_cmos 00:05: registered as rtc0 [ 3.327800] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.328971] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.335093] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.336115] intel_pstate: CPU model not supported [ 3.341113] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.343975] hid: raw HID events driver (C) Jiri Kosina [ 3.346754] usbcore: registered new interface driver usbhid [ 3.348495] usbhid: USB HID core driver [ 3.349875] drop_monitor: Initializing network drop monitor service [ 3.352068] Initializing XFRM netlink socket [ 3.353865] NET: Registered protocol family 10 [ 3.356837] Segment Routing with IPv6 [ 3.358136] NET: Registered protocol family 17 [ 3.360730] mpls_gso: MPLS GSO support [ 3.367127] RAS: Correctable Errors collector initialized. [ 3.369445] AVX version of gcm_enc/dec engaged. [ 3.371031] AES CTR mode by8 optimization enabled [ 3.465961] sched_clock: Marking stable (3465935639, 0)->(4325883659, -859948020) [ 3.469531] registered taskstats version 1 [ 3.472345] Loading compiled-in X.509 certificates [ 3.474053] zswap: loaded using pool lzo/zbud [ 3.499061] Key type big_key registered [ 3.511954] Key type encrypted registered [ 3.513695] ima: No TPM chip found, activating TPM-bypass! [ 3.515926] ima: Allocated hash algorithm: sha1 [ 3.517692] ima: No architecture policies found [ 3.519260] evm: Initialising EVM extended attributes: [ 3.521815] evm: security.selinux [ 3.523131] evm: security.ima [ 3.525639] evm: security.capability [ 3.527055] evm: HMAC attrs: 0x1 [ 3.529540] rtc_cmos 00:05: setting system clock to 2026-08-05 12:41:45 UTC (1785933705) [ 3.535335] debug: unmapping init [mem 0xffffffffafe03000-0xffffffffafffffff] [ 3.538307] debug: unmapping init [mem 0xffffffffaeb82000-0xffffffffaee58fff] [ 3.547057] Write protecting the kernel read-only data: 28672k [ 3.550526] debug: unmapping init [mem 0xffffffffad203000-0xffffffffad3fffff] [ 3.553634] debug: unmapping init [mem 0xffffffffadb14000-0xffffffffadbfffff] [ 3.584666] 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.592448] systemd[1]: Detected virtualization kvm. [ 3.593806] systemd[1]: Detected architecture x86-64. [ 3.595302] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.620756] systemd[1]: No hostname configured. [ 3.622259] systemd[1]: Set hostname to . [ 3.624098] random: systemd: uninitialized urandom read (16 bytes read) [ 3.626383] systemd[1]: Initializing machine ID from random generator. [ 3.666152] random: ln: uninitialized urandom read (6 bytes read) [ 3.742243] random: systemd: uninitialized urandom read (16 bytes read) [ 3.745383] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.750212] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.757769] systemd[1]: Reached target Paths. [ OK ] Reached target Paths. [ OK ] Listening on udev Control Socket. [ OK ] Listening on Journal Socket. [ OK ] Reached target Local File Systems. Starting Setup Virtual Console... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Swap. Starting Create Volatile Files and Directories... [ OK ] Reached target Initrd Root Device. Starting Apply Kernel Variables... [ OK ] Reached target Slices. [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.291531] device-mapper: uevent: version 1.0.3 [ 4.294151] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.922724] virtio_net virtio0 ens2: renamed from eth0 [ 4.956177] scsi host0: ata_piix [ 4.974436] scsi host1: ata_piix [ 4.976522] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.980043] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.336886] dracut-initqueue[588]: RTNETLINK answers: File exists [ 10.052434] random: crng init done [ 10.056814] 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). [ 11.648763] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Reached target Remote File Systems. [ 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... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ 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 Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 14.453211] printk: systemd: 26 output lines suppressed due to ratelimiting [ 15.112965] SELinux: Disabled at runtime. [ 15.268696] 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) [ 15.289195] systemd[1]: Detected virtualization kvm. [ 15.299552] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 17.445764] systemd[1]: initrd-switch-root.service: Succeeded. [ 17.452603] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 17.470403] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 17.479740] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 17.488338] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 17.505526] systemd[1]: Starting Journal Service... Starting Journal Service... [ 17.518271] 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. Mounting Kernel Debug File System... [ OK ] Created slice User and Session Slice. Mounting POSIX Message Queue File System... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Dispatch Password Requests to Console Directory Watch. Activating swap /dev/disk/by-label/SWAP... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Created slice system-getty.slice. [ OK ] Listening on udev Control Socket. [ 17.808870] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Reached target Slices. Starting Remount Root and Kernel File Systems... Starting Apply Kernel Variables... [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Reached target Paths. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Stopped target Initrd Root File System. Mounting Huge Pages File System... [ OK ] Reached target rpc_pipefs.target. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Huge Pages File System. Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... [ OK ] Started udev Coldplug all Devices. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 19.334113] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 20.759622] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 20.815911] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 21.675707] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 21.949443] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit) [** ] A start job is running for Configur…-only root support (8s / no limit)[ 26.573830] Key type dns_resolver registered [*** ] A start job is running for Configur…-only root support (9s / no limit) [ *** ] A start job is running for Configur…only root support (10s / no limit)[ 27.722641] NFS: Registering the id_resolver key type [ 27.725228] Key type id_resolver registered [ 27.727766] Key type id_legacy registered [ *** ] A start job is running for Configur…only root support (10s / no limit) [ ***] A start job is running for Configur…only root support (11s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started D-Bus System Message Bus. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. Starting Network Manager... [ OK ] Reached target sshd-keygen.target. [ 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. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg320-client login: [ 123.184241] libcfs: loading out-of-tree module taints kernel. [ 123.401500] Key type ._llcrypt registered [ 123.406711] Key type .llcrypt registered [ 124.457624] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 124.489934] alg: No test for adler32 (adler32-zlib) [ 126.337949] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 127.715479] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 129.744157] Key type lgssc registered [ 132.563953] Lustre: Echo OBD driver; http://www.lustre.org/ [ 229.418019] hrtimer: interrupt took 2215241 ns [ 374.033074] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 381.205485] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 398.339917] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing check_logdir /tmp/testlogs/ [ 399.842450] Lustre: lustre-OST0000-osc-ffff8a02c7897000: disconnect after 22s idle [ 405.843325] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing yml_node [ 414.125091] Lustre: DEBUG MARKER: Client: 2.17.56.50 [ 418.113824] Lustre: DEBUG MARKER: MDS: 2.17.56.50 [ 420.708602] Lustre: DEBUG MARKER: OSS: 2.17.56.50 [ 423.560427] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Aug 5 08:48:42 EDT 2026 [ 447.927911] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 449.548701] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 455.982728] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 466.431597] Lustre: Unmounted lustre-client [ 633.550556] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 640.709723] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 675.234913] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 725.036695] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 08:53:44 (1785934424) [ 727.979344] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 730.320776] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 08:53:50 (1785934430) [ 775.537802] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 783.621077] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 816.564949] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 817.363134] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 825.754672] Lustre: Unmounted lustre-client [ 860.528670] Key type lgssc unregistered [ 860.898845] LNet: 15073:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 860.911244] LNetError: 15073:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 860.969570] LNet: Removed LNI 192.168.203.20@tcp [ 862.315035] Key type .llcrypt unregistered [ 862.317668] Key type ._llcrypt unregistered [ 884.533287] Key type ._llcrypt registered [ 884.537798] Key type .llcrypt registered [ 886.242877] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 08:56:26 (1785934586) [ 888.993314] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 889.068938] alg: No test for adler32 (adler32-zlib) [ 890.425598] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 890.915695] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 892.784160] Key type lgssc registered [ 894.450447] Lustre: Echo OBD driver; http://www.lustre.org/ [ 998.015979] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 1090.611709] Lustre: Unmounted lustre-client [ 1135.279201] Key type lgssc unregistered [ 1135.903595] LNet: 18887:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1135.922697] LNetError: 18887:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1135.968489] LNet: Removed LNI 192.168.203.20@tcp [ 1137.113677] Key type .llcrypt unregistered [ 1137.115500] Key type ._llcrypt unregistered [ 1154.513400] Key type ._llcrypt registered [ 1154.517242] Key type .llcrypt registered [ 1157.894378] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 09:00:56 (1785934856) [ 1161.546397] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1161.595460] alg: No test for adler32 (adler32-zlib) [ 1162.811672] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 1163.199107] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 1165.000260] Key type lgssc registered [ 1166.868151] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1237.298277] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1245.194720] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1276.494068] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1278.723955] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 1292.041534] Lustre: Unmounted lustre-client [ 1328.139945] Key type lgssc unregistered [ 1328.550800] LNet: 22511:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1328.566668] LNetError: 22511:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1328.616916] LNet: Removed LNI 192.168.203.20@tcp [ 1330.331990] Key type .llcrypt unregistered [ 1330.336493] Key type ._llcrypt unregistered [ 1347.874867] Key type ._llcrypt registered [ 1347.879162] Key type .llcrypt registered [ 1349.519882] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 09:04:09 (1785935049) [ 1353.455506] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1353.651592] alg: No test for adler32 (adler32-zlib) [ 1355.026754] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 1355.555896] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 1357.408399] Key type lgssc registered [ 1359.116791] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1432.026785] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1440.624460] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1469.864203] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1473.094894] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 1482.305671] Lustre: Unmounted lustre-client [ 1518.638901] Key type lgssc unregistered [ 1519.298954] LNet: 25713:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1519.316654] LNetError: 25713:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1519.362964] LNet: Removed LNI 192.168.203.20@tcp [ 1520.734578] Key type .llcrypt unregistered [ 1520.738896] Key type ._llcrypt unregistered [ 1544.481555] Key type ._llcrypt registered [ 1544.486217] Key type .llcrypt registered [ 1546.523432] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 09:07:26 (1785935246) [ 1549.686358] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1549.796780] alg: No test for adler32 (adler32-zlib) [ 1551.095731] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 1551.535642] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 1553.336807] Key type lgssc registered [ 1555.001451] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1627.385854] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1635.182230] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1661.385710] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1663.256605] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 1673.714678] Lustre: lustre-MDT0000-mdc-ffff8a02cb1d3000: Connection to lustre-MDT0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1683.948870] Lustre: lustre-MDT0001-mdc-ffff8a02cb1d3000: Connection to lustre-MDT0001 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1691.895276] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1694.176162] Lustre: 26676:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1785935380/real 1785935380] req@00000000fad5569b x1872688843855744/t0(0) o400->MGC192.168.203.120@tcp@192.168.203.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1785935396 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1694.226404] LustreError: MGC192.168.203.120@tcp: Connection to MGS (at 192.168.203.120@tcp) was lost; in progress operations using this service will fail [ 1702.262680] Lustre: Unmounted lustre-client [ 1720.072245] Key type lgssc unregistered [ 1720.597767] LNet: 29379:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1720.621814] LNetError: 29379:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1720.648191] LNet: Removed LNI 192.168.203.20@tcp [ 1722.442071] Key type .llcrypt unregistered [ 1722.445512] Key type ._llcrypt unregistered [ 1748.270927] Key type ._llcrypt registered [ 1748.290394] Key type .llcrypt registered [ 1749.989807] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 09:10:49 (1785935449) [ 1753.199344] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1753.299136] alg: No test for adler32 (adler32-zlib) [ 1754.546392] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 1754.843204] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 1756.552181] Key type lgssc registered [ 1758.589941] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1828.839587] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1836.703483] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1867.492486] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1870.687538] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 1875.963168] Lustre: lustre-OST0000-osc-ffff8a02d2183000: Connection to lustre-OST0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1885.441397] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1895.893884] Lustre: Unmounted lustre-client [ 1939.824180] Key type lgssc unregistered [ 1940.593303] LNet: 33007:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1940.662528] LNetError: 33007:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1940.740846] LNet: Removed LNI 192.168.203.20@tcp [ 1942.256141] Key type .llcrypt unregistered [ 1942.267232] Key type ._llcrypt unregistered [ 1966.374228] Key type ._llcrypt registered [ 1966.375723] Key type .llcrypt registered [ 1968.177863] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 09:14:28 (1785935668) [ 1971.417045] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1971.447273] alg: No test for adler32 (adler32-zlib) [ 1972.781277] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 1973.226358] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 1974.992200] Key type lgssc registered [ 1977.052313] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2047.998147] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2058.802485] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2088.261119] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2091.453172] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 2096.679739] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 2101.976569] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 2114.531930] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-05 9h16m54s [ 2118.273867] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 2122.236973] Lustre: lustre-MDT0000-mdc-ffff8a02cb1d0800: Connection to lustre-MDT0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2130.171906] LustreError: 36804:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8a02cb1d0800: can't stat MDS #0: rc = -19 [ 2132.655331] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 2142.191382] LustreError: MGC192.168.203.120@tcp: Connection to MGS (at 192.168.203.120@tcp) was lost; in progress operations using this service will fail [ 2142.224850] Lustre: Evicted from MGS (at 192.168.203.120@tcp) after server handle changed from 0x6062210acb786d7d to 0x6062210acb786e87 [ 2142.248252] Lustre: MGC192.168.203.120@tcp: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [ 2148.335495] LustreError: lustre-MDT0000-mdc-ffff8a02cb1d0800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 2148.353760] Lustre: lustre-MDT0000-mdc-ffff8a02cb1d0800: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [ 2154.360599] Lustre: DEBUG MARKER: Wait for df (36804) ... [ 2156.103514] Lustre: DEBUG MARKER: done [ 2159.930027] Lustre: Unmounted lustre-client [ 2192.697015] Key type lgssc unregistered [ 2193.060625] LNet: 37826:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2193.071795] LNetError: 37826:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2193.101912] LNet: Removed LNI 192.168.203.20@tcp [ 2194.437993] Key type .llcrypt unregistered [ 2194.447332] Key type ._llcrypt unregistered [ 2245.799316] Key type ._llcrypt registered [ 2245.801268] Key type .llcrypt registered [ 2247.436892] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 09:19:07 (1785935947) [ 2251.321488] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2251.357096] alg: No test for adler32 (adler32-zlib) [ 2252.465705] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 2252.787458] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 2254.577381] Key type lgssc registered [ 2256.342326] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2334.213910] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2341.444366] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2369.640448] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2371.591048] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 2377.001957] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-05 9h21m17s [ 2378.878637] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 2388.047983] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 2391.226514] Lustre: DEBUG MARKER: Creating a test file and stat it [ 2411.488151] Lustre: 41986:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1785936093/real 1785936093] req@0000000083a98aff x1872689578908032/t0(0) o101->lustre-MDT0000-mdc-ffff8a02d013f000@192.168.203.120@tcp:12/10 lens 576/1152 e 0 to 1 dl 1785936113 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 2411.550114] Lustre: lustre-MDT0000-mdc-ffff8a02d013f000: Connection to lustre-MDT0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2411.687897] Lustre: lustre-MDT0000-mdc-ffff8a02d013f000: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [ 2433.584215] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 2437.823171] Lustre: DEBUG MARKER: done [ 2444.192810] Lustre: Unmounted lustre-client [ 2480.944775] Key type lgssc unregistered [ 2481.476441] LNet: 42868:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2481.499943] LNetError: 42868:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2481.529040] LNet: Removed LNI 192.168.203.20@tcp [ 2482.852515] Key type .llcrypt unregistered [ 2482.857951] Key type ._llcrypt unregistered [ 2531.045583] Key type ._llcrypt registered [ 2531.064923] Key type .llcrypt registered [ 2532.773227] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 09:23:52 (1785936232) [ 2535.981811] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2539.279740] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 09:23:58 (1785936238) [ 2545.918803] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2545.949584] alg: No test for adler32 (adler32-zlib) [ 2547.553866] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 2548.291527] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 2550.200165] Key type lgssc registered [ 2552.796092] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2607.059561] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 09:25:06 (1785936306) [ 2659.223702] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2667.577159] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2697.249182] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2698.983523] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 2703.720587] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2708.308677] Lustre: Unmounted lustre-client [ 2728.592845] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2794.299500] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2803.710153] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2804.801911] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 2809.477517] Lustre: Unmounted lustre-client [ 2903.141942] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2912.218248] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2913.294692] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 2920.498386] Lustre: Unmounted lustre-client [ 2950.838044] Lustre: DEBUG MARKER: files compared the same [ 2980.196676] Key type lgssc unregistered [ 2980.573813] LNet: 50537:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2980.586343] LNetError: 50537:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2981.639614] LNet: Removed LNI 192.168.203.20@tcp [ 2983.100917] Key type .llcrypt unregistered [ 2983.105240] Key type ._llcrypt unregistered [ 3012.019703] Key type ._llcrypt registered [ 3012.025308] Key type .llcrypt registered [ 3013.813118] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 09:31:53 (1785936713) [ 3016.580442] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3016.789272] alg: No test for adler32 (adler32-zlib) [ 3017.975224] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 3018.445918] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 3020.280381] Key type lgssc registered [ 3022.000735] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3093.849795] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3102.563389] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3132.420612] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3134.333720] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 3140.152139] Lustre: Unmounted lustre-client [ 3172.850364] Key type lgssc unregistered [ 3173.285642] LNet: 54133:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3173.304833] LNetError: 54133:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3173.321298] LNet: Removed LNI 192.168.203.20@tcp [ 3174.553925] Key type .llcrypt unregistered [ 3174.559244] Key type ._llcrypt unregistered [ 3196.665880] Key type ._llcrypt registered [ 3196.676600] Key type .llcrypt registered [ 3198.868262] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 09:34:58 (1785936898) [ 3203.273253] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3203.598652] alg: No test for adler32 (adler32-zlib) [ 3205.310430] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 3205.772181] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 3207.688193] Key type lgssc registered [ 3209.720722] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3313.514535] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3361.401364] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3369.418439] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3405.533554] Key type lgssc unregistered [ 3405.806509] LNet: 57632:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3405.815748] LNetError: 57632:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3405.832578] LNet: Removed LNI 192.168.203.20@tcp [ 3406.694539] Key type .llcrypt unregistered [ 3406.698936] Key type ._llcrypt unregistered [ 3430.125279] Key type ._llcrypt registered [ 3430.131251] Key type .llcrypt registered [ 3431.994731] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 09:38:51 (1785937131) [ 3437.012807] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3437.035281] alg: No test for adler32 (adler32-zlib) [ 3438.426731] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 3438.852927] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 3440.568170] Key type lgssc registered [ 3442.213061] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3554.338727] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 3564.101733] Lustre: Unmounted lustre-client [ 3608.997555] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 09:41:49 (1785937309) [ 3777.431971] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3802.204591] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 3810.449132] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3810.462497] LustreError: 64138:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8a02cca56000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3810.527086] Lustre: 58620:0:(llite_lib.c:4340:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.120@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3820.904289] Lustre: Unmounted lustre-client [ 3880.017787] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 09:46:19 (1785937579) [ 3894.986728] Key type lgssc unregistered [ 3895.412230] LNet: 65354:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3895.423980] LNetError: 65354:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3896.487224] LNet: Removed LNI 192.168.203.20@tcp [ 3897.572637] Key type .llcrypt unregistered [ 3897.579811] Key type ._llcrypt unregistered [ 3914.192699] Key type ._llcrypt registered [ 3914.199933] Key type .llcrypt registered [ 3914.737257] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3914.761906] alg: No test for adler32 (adler32-zlib) [ 3915.968378] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 3916.319670] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 3917.992261] Key type lgssc registered [ 3919.524462] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3987.915413] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3995.726249] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4020.273477] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4026.451746] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 4033.119388] Lustre: Unmounted lustre-client [ 4065.222548] Key type lgssc unregistered [ 4065.507392] LNet: 68379:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4065.524162] LNetError: 68379:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4065.544733] LNet: Removed LNI 192.168.203.20@tcp [ 4066.645675] Key type .llcrypt unregistered [ 4066.651661] Key type ._llcrypt unregistered [ 4081.827668] Key type ._llcrypt registered [ 4081.843589] Key type .llcrypt registered [ 4082.427779] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4082.455200] alg: No test for adler32 (adler32-zlib) [ 4083.732558] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 4084.391156] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 4086.192292] Key type lgssc registered [ 4088.127579] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4228.733525] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4236.703224] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4269.701766] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4271.714827] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 4275.438729] Lustre: Unmounted lustre-client [ 4316.871829] Key type lgssc unregistered [ 4317.260625] LNet: 71821:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4317.269612] LNetError: 71821:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4317.285129] LNet: Removed LNI 192.168.203.20@tcp [ 4318.755122] Key type .llcrypt unregistered [ 4318.768043] Key type ._llcrypt unregistered [ 4343.605995] Key type ._llcrypt registered [ 4343.609388] Key type .llcrypt registered [ 4345.526760] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 09:54:05 (1785938045) [ 4348.435047] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4348.496595] alg: No test for adler32 (adler32-zlib) [ 4349.987945] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 4350.502678] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 4352.288169] Key type lgssc registered [ 4353.529790] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4436.003749] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4447.776267] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4478.376955] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4480.809728] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 4488.939988] Lustre: Unmounted lustre-client [ 4489.777617] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 4493.179208] Lustre: Unmounted lustre-client [ 4527.861337] Key type lgssc unregistered [ 4528.438914] LNet: 75517:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4528.463597] LNetError: 75517:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4528.506380] LNet: Removed LNI 192.168.203.20@tcp [ 4529.764198] Key type .llcrypt unregistered [ 4529.767397] Key type ._llcrypt unregistered [ 4549.617323] Key type ._llcrypt registered [ 4549.625140] Key type .llcrypt registered [ 4550.390619] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4550.424061] alg: No test for adler32 (adler32-zlib) [ 4551.819354] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 4552.236854] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 4554.080221] Key type lgssc registered [ 4556.073988] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4632.467737] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4641.675662] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4670.299387] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4672.224715] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 4679.105944] Lustre: Unmounted lustre-client [ 4719.378821] Key type lgssc unregistered [ 4719.939960] LNet: 78565:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4719.956557] LNetError: 78565:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4720.020286] LNet: Removed LNI 192.168.203.20@tcp [ 4721.483724] Key type .llcrypt unregistered [ 4721.493590] Key type ._llcrypt unregistered [ 4745.839055] Key type ._llcrypt registered [ 4745.843346] Key type .llcrypt registered [ 4747.676386] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 10:00:47 (1785938447) [ 4750.221903] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4750.236773] alg: No test for adler32 (adler32-zlib) [ 4751.612628] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 4751.923239] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 4753.720218] Key type lgssc registered [ 4756.464403] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4823.567912] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4831.376164] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4864.000843] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4867.091519] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 4878.988435] Lustre: lustre: root_squash is set to 0:0 [ 4887.695701] Lustre: lustre: nosquash_nids is cleared [ 4887.778137] Lustre: lustre: root_squash is set to 500:500 [ 4906.020502] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.20@tcp 192.168.0.[2,10]@tcp [ 4921.447816] Lustre: lustre: nosquash_nids set to 192.168.203.20/24@tcp [ 4925.999978] Lustre: Unmounted lustre-client [ 4958.004462] Key type lgssc unregistered [ 4958.373254] LNet: 82550:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4958.377864] LNetError: 82550:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4958.397417] LNet: Removed LNI 192.168.203.20@tcp [ 4959.482937] Key type .llcrypt unregistered [ 4959.486425] Key type ._llcrypt unregistered [ 4978.440345] Key type ._llcrypt registered [ 4978.444388] Key type .llcrypt registered [ 4980.180100] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 10:04:40 (1785938680) [ 4983.453752] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 4985.225181] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 10:04:45 (1785938685) [ 4988.783703] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4988.815603] alg: No test for adler32 (adler32-zlib) [ 4990.012641] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 4990.440501] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 4992.232163] Key type lgssc registered [ 4993.476767] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5066.675323] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5073.765136] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5099.664867] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5101.480982] Lustre: lustre: root_squash is set to 500:500 [ 5101.522409] Lustre: lustre: nosquash_nids set to 192.168.203.20/24@tcp [ 5102.625601] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 5110.757740] Lustre: Unmounted lustre-client [ 5143.465537] Key type lgssc unregistered [ 5143.808667] LNet: 86525:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5143.820473] LNetError: 86525:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5143.842109] LNet: Removed LNI 192.168.203.20@tcp [ 5144.888389] Key type .llcrypt unregistered [ 5144.895794] Key type ._llcrypt unregistered [ 5167.422502] Key type ._llcrypt registered [ 5167.429663] Key type .llcrypt registered [ 5169.780704] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 5172.782435] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 10:07:52 (1785938872) [ 5202.810496] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5202.837149] alg: No test for adler32 (adler32-zlib) [ 5204.143913] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 5204.410557] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 5206.152363] Key type lgssc registered [ 5207.459735] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5318.935984] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5327.805279] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5372.557872] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5481.398384] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5489.649732] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5518.138083] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5540.329455] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 5593.404599] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8a02c64c0800.ost_server_uuid 50 [ 5595.489710] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8a02c64c0800.ost_server_uuid in IDLE state after 0 sec [ 5596.812338] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 5605.650263] Lustre: Unmounted lustre-client [ 5611.195150] Lustre: Unmounted lustre-client [ 5698.792598] Key type lgssc unregistered [ 5699.255263] LNet: 94221:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5699.264552] LNetError: 94221:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5699.304502] LNet: Removed LNI 192.168.203.20@tcp [ 5700.788950] Key type .llcrypt unregistered [ 5700.791082] Key type ._llcrypt unregistered [ 5746.237189] Key type ._llcrypt registered [ 5746.241755] Key type .llcrypt registered [ 5748.171143] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 10:17:27 (1785939447) [ 5771.936336] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5772.169428] alg: No test for adler32 (adler32-zlib) [ 5773.471533] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 5773.888564] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 5775.744185] Key type lgssc registered [ 5777.496434] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5898.229963] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5907.778294] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5940.250578] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5942.844487] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 5963.041292] Lustre: 95587:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1785939649/real 1785939649] req@00000000e0335d99 x1872693270942976/t0(0) o400->lustre-OST0000-osc-ffff8a02c53c1800@192.168.203.120@tcp:28/4 lens 224/224 e 0 to 1 dl 1785939665 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5963.104141] Lustre: lustre-OST0000-osc-ffff8a02c53c1800: Connection to lustre-OST0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5968.288553] Lustre: 95586:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1785939654/real 1785939654] req@00000000787b87fc x1872693270943488/t0(0) o400->lustre-OST0000-osc-ffff8a02c53c1800@192.168.203.120@tcp:28/4 lens 224/224 e 0 to 1 dl 1785939670 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5974.305577] Lustre: 95586:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1785939660/real 1785939660] req@0000000082dbffa5 x1872693270944000/t0(0) o400->lustre-OST0000-osc-ffff8a02c53c1800@192.168.203.120@tcp:28/4 lens 224/224 e 0 to 1 dl 1785939676 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5976.388801] Lustre: lustre-OST0000-osc-ffff8a02c53c1800: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [ 5983.718355] Lustre: lustre-MDT0000-mdc-ffff8a02c53c1800: Connection to lustre-MDT0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6004.192532] Lustre: 95587:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1785939690/real 1785939690] req@000000006a43f060 x1872693270947456/t0(0) o400->MGC192.168.203.120@tcp@192.168.203.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1785939706 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 6004.247200] LustreError: MGC192.168.203.120@tcp: Connection to MGS (at 192.168.203.120@tcp) was lost; in progress operations using this service will fail [ 6014.480074] Lustre: Evicted from MGS (at 192.168.203.120@tcp) after server handle changed from 0x9f964582e9a3379b to 0x9f964582e9a33931 [ 6014.500775] Lustre: MGC192.168.203.120@tcp: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [ 6020.235372] Lustre: lustre-MDT0000-mdc-ffff8a02c53c1800: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [ 6030.216262] Lustre: Unmounted lustre-client [ 6068.542974] Key type lgssc unregistered [ 6069.054994] LNet: 99902:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6069.072144] LNetError: 99902:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6070.133444] LNet: Removed LNI 192.168.203.20@tcp [ 6071.573704] Key type .llcrypt unregistered [ 6071.575344] Key type ._llcrypt unregistered [ 6098.585209] Key type ._llcrypt registered [ 6098.594189] Key type .llcrypt registered [ 6100.649643] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 10:23:20 (1785939800) [ 6118.236834] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6118.245936] alg: No test for adler32 (adler32-zlib) [ 6119.596555] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 6119.967067] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 6121.832155] Key type lgssc registered [ 6123.833680] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6183.496168] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6315.587733] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6323.900380] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6359.356701] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6362.296711] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 6365.526332] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 6367.665205] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 10:27:47 (1785940067) [ 6695.145792] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6705.575607] Lustre: Unmounted lustre-client [ 6877.671183] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6886.813246] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6918.906220] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6969.026817] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:37:48 (1785940668) [ 7098.170905] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7105.489524] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7134.951651] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7136.549602] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 7146.440195] Lustre: Unmounted lustre-client [ 7189.134515] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:41:28 (1785940888) [ 7312.439289] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7320.773726] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7354.516390] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7355.447740] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 7362.159972] Lustre: Unmounted lustre-client [ 7395.993347] Key type lgssc unregistered [ 7396.485781] LNet: 122976:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7396.508124] LNetError: 122976:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7397.572113] LNet: Removed LNI 192.168.203.20@tcp [ 7398.846818] Key type .llcrypt unregistered [ 7398.848309] Key type ._llcrypt unregistered [ 7422.251974] Key type ._llcrypt registered [ 7422.254447] Key type .llcrypt registered [ 7424.256995] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 10:45:23 (1785941123) [ 7427.524069] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7427.557440] alg: No test for adler32 (adler32-zlib) [ 7428.999415] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 7429.340873] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 7431.168354] Key type lgssc registered [ 7434.486288] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7515.386589] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7521.728252] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7553.112585] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7555.996997] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 7572.669442] Lustre: Unmounted lustre-client [ 7605.222440] Key type lgssc unregistered [ 7605.682846] LNet: 126582:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7605.687199] LNetError: 126582:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7605.719433] LNet: Removed LNI 192.168.203.20@tcp [ 7606.691092] Key type .llcrypt unregistered [ 7606.698445] Key type ._llcrypt unregistered [ 7629.323874] Key type ._llcrypt registered [ 7629.327162] Key type .llcrypt registered [ 7631.224875] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 10:48:51 (1785941331) [ 7635.037244] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7635.055868] alg: No test for adler32 (adler32-zlib) [ 7636.322287] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 7636.733344] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 7638.576414] Key type lgssc registered [ 7640.789191] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7702.165936] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7709.727359] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7738.373170] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7741.638682] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 7747.048625] Lustre: lustre-OST0000-osc-ffff8a02c9aef000: Connection to lustre-OST0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7763.638904] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8a02c9aef000.ost_server_uuid 50 [ 7765.878784] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 7779.771486] Lustre: Unmounted lustre-client [ 7805.760532] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 10:51:46 (1785941506) [ 7849.047946] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7858.429258] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7895.023255] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7925.732191] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7926.509329] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 7931.890518] Lustre: lustre-OST0000-osc-ffff8a02ca047800: Connection to lustre-OST0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7963.463712] Lustre: Unmounted lustre-client [ 8018.609810] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 10:55:18 (1785941718) [ 8070.892436] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8077.791507] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8105.059232] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8135.495481] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8136.452796] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 8141.813759] Lustre: lustre-OST0000-osc-ffff8a02ca553800: Connection to lustre-OST0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8159.122239] Lustre: Unmounted lustre-client [ 8212.997544] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 10:58:33 (1785941913) [ 8336.048843] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8343.698211] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8373.446730] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8466.707814] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8474.345944] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8500.935280] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8542.511105] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 8592.428708] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8594.734340] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8598.759759] Lustre: Unmounted lustre-client [ 8639.317186] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 11:05:39 (1785942339) [ 8688.163616] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8698.728733] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8730.497757] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8782.824482] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8820.115672] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 8868.088812] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8870.108933] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8885.728839] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8896.133633] Lustre: Unmounted lustre-client [ 8960.214564] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 11:11:00 (1785942660) [ 9010.164037] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9018.611218] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9046.783849] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9047.410224] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 9082.763349] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9085.696413] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in IDLE state after 0 sec [ 9109.659157] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8a02cb1d5800.ost_server_uuid 50 [ 9112.371167] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8a02cb1d5800.ost_server_uuid in IDLE state after 0 sec [ 9119.506820] Lustre: Unmounted lustre-client [ 9120.061627] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 9120.068569] Lustre: Skipped 3 previous similar messages [ 9120.162965] LustreError: 127543:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 9120.229696] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 9121.707249] LustreError: 150071:0:(sec.c:403:import_sec_validate_get()) import 00000000efed8297 (NEW) with no sec [ 9205.946549] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 11:15:06 (1785942906) [ 9260.338421] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9268.836494] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9294.561605] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9324.300651] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9324.831603] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 9325.034322] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 9338.815134] Lustre: Unmounted lustre-client [ 9338.816601] Lustre: Skipped 1 previous similar message [ 9381.635084] Key type lgssc unregistered [ 9382.081126] LNet: 153486:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9382.091104] LNetError: 153486:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9382.109178] LNet: Removed LNI 192.168.203.20@tcp [ 9383.314173] Key type .llcrypt unregistered [ 9383.317463] Key type ._llcrypt unregistered [ 9404.125363] Key type ._llcrypt registered [ 9404.129630] Key type .llcrypt registered [ 9405.432212] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 11:18:25 (1785943105) [ 9407.304724] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9407.344047] alg: No test for adler32 (adler32-zlib) [ 9408.695899] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 9409.161116] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 9411.009697] Key type lgssc registered [ 9412.655077] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9477.385389] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9485.805593] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9513.521203] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9538.243904] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9540.071786] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 9541.256646] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 9546.729221] LustreError: lustre-MDT0001-mdc-ffff8a02ca044000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 9546.764670] Lustre: lustre-MDT0001-mdc-ffff8a02ca044000: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [ 9554.112784] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9555.629929] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9578.016530] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 9591.854395] Lustre: Unmounted lustre-client [ 9632.018765] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 11:22:12 (1785943332) [ 9765.751571] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9775.460233] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9806.630295] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9807.580534] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [ 9843.647398] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9847.258569] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 9865.533520] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9875.976177] Lustre: Unmounted lustre-client [ 9927.037555] Key type lgssc unregistered [ 9927.497704] LNet: 163112:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9927.518269] LNetError: 163112:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9927.547613] LNet: Removed LNI 192.168.203.20@tcp [ 9928.385716] Key type .llcrypt unregistered [ 9928.390570] Key type ._llcrypt unregistered [ 9975.462328] Key type ._llcrypt registered [ 9975.466326] Key type .llcrypt registered [ 9978.078943] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 11:27:57 (1785943677) [ 9984.973539] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9985.032775] alg: No test for adler32 (adler32-zlib) [ 9986.225973] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [ 9986.507915] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [ 9988.272229] Key type lgssc registered [ 9990.594788] Lustre: Echo OBD driver; http://www.lustre.org/ [10063.772065] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10074.173830] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10113.680580] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10116.466689] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [10169.095922] Lustre: Unmounted lustre-client [10219.618322] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10220.494446] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [10260.157026] Lustre: Unmounted lustre-client [10301.603176] Key type lgssc unregistered [10301.952987] LNet: 167577:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10301.956299] LNetError: 167577:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10301.995902] LNet: Removed LNI 192.168.203.20@tcp [10303.221280] Key type .llcrypt unregistered [10303.224288] Key type ._llcrypt unregistered [10325.780111] Key type ._llcrypt registered [10325.782118] Key type .llcrypt registered [10326.947245] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 11:33:47 (1785944027) [10329.719119] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10329.764802] alg: No test for adler32 (adler32-zlib) [10330.971339] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [10331.370221] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [10333.184870] Key type lgssc registered [10335.440507] Lustre: Echo OBD driver; http://www.lustre.org/ [10414.808786] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10423.541973] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10457.076370] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10460.185429] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [10485.714666] Lustre: Unmounted lustre-client [10520.515164] Key type lgssc unregistered [10521.158644] LNet: 171343:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10521.177247] LNetError: 171343:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10521.199561] LNet: Removed LNI 192.168.203.20@tcp [10521.977288] Key type .llcrypt unregistered [10521.979416] Key type ._llcrypt unregistered [10540.315294] Key type ._llcrypt registered [10540.317143] Key type .llcrypt registered [10540.553265] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10540.574601] alg: No test for adler32 (adler32-zlib) [10541.894921] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [10542.251382] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [10543.919646] Key type lgssc registered [10546.284912] Lustre: Echo OBD driver; http://www.lustre.org/ [10627.201678] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10639.262841] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10675.036582] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10676.840241] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [10690.249317] Lustre: Unmounted lustre-client [10730.929677] Key type lgssc unregistered [10731.353826] LNet: 174426:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10731.367943] LNetError: 174426:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10731.390294] LNet: Removed LNI 192.168.203.20@tcp [10733.042784] Key type .llcrypt unregistered [10733.051525] Key type ._llcrypt unregistered [10762.190637] Key type ._llcrypt registered [10762.192213] Key type .llcrypt registered [10764.510332] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 11:41:03 (1785944463) [10769.122570] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10769.141380] alg: No test for adler32 (adler32-zlib) [10770.559183] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [10771.123353] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [10772.888214] Key type lgssc registered [10774.200420] Lustre: Echo OBD driver; http://www.lustre.org/ [10836.192795] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10843.374928] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10873.060992] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10876.020360] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [10906.878191] Lustre: Unmounted lustre-client [10948.870343] Key type lgssc unregistered [10949.736735] LNet: 178192:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10949.741330] LNetError: 178192:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10949.784545] LNet: Removed LNI 192.168.203.20@tcp [10952.115095] Key type .llcrypt unregistered [10952.116606] Key type ._llcrypt unregistered [10973.858152] Key type ._llcrypt registered [10973.868844] Key type .llcrypt registered [10974.941468] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10974.994604] alg: No test for adler32 (adler32-zlib) [10976.506562] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [10977.227174] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [10979.304216] Key type lgssc registered [10981.158941] Lustre: Echo OBD driver; http://www.lustre.org/ [11054.306291] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11064.360230] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11097.563937] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11099.935911] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [11109.494766] Lustre: Unmounted lustre-client [11145.410972] Key type lgssc unregistered [11145.742222] LNet: 181268:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11145.760891] LNetError: 181268:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11145.803221] LNet: Removed LNI 192.168.203.20@tcp [11146.681381] Key type .llcrypt unregistered [11146.686976] Key type ._llcrypt unregistered [11166.681489] Key type ._llcrypt registered [11166.685312] Key type .llcrypt registered [11168.623833] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 11:47:48 (1785944868) [11199.984135] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11200.118272] alg: No test for adler32 (adler32-zlib) [11201.402771] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [11201.665858] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [11203.416173] Key type lgssc registered [11205.290208] Lustre: Echo OBD driver; http://www.lustre.org/ [11315.736854] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11324.443872] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11361.633518] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11425.260975] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 11:52:04 (1785945124) [11484.717927] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11494.275039] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11524.108955] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11525.971842] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [11536.228396] Lustre: Unmounted lustre-client [11567.766627] Key type lgssc unregistered [11568.155379] LNet: 188386:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11568.163827] LNetError: 188386:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11568.182235] LNet: Removed LNI 192.168.203.20@tcp [11569.287951] Key type .llcrypt unregistered [11569.292636] Key type ._llcrypt unregistered [11592.626700] Key type ._llcrypt registered [11592.632411] Key type .llcrypt registered [11594.267544] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [11596.372455] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 11:54:56 (1785945296) [11620.280997] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11620.430170] alg: No test for adler32 (adler32-zlib) [11621.706512] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [11622.085574] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [11623.832186] Key type lgssc registered [11626.232508] Lustre: Echo OBD driver; http://www.lustre.org/ [11765.606689] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11773.576797] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11807.934516] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11836.131680] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11839.170726] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [11879.382051] Lustre: Unmounted lustre-client [12059.882153] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12067.019263] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12105.012528] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12174.524857] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 12:04:34 (1785945874) [12176.460597] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [12179.204359] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 12:04:38 (1785945878) [12317.702551] Key type lgssc unregistered [12318.042032] LNet: 199874:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12318.084364] LNetError: 199874:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12318.110133] LNet: Removed LNI 192.168.203.20@tcp [12319.382639] Key type .llcrypt unregistered [12319.389700] Key type ._llcrypt unregistered [12347.799508] Key type ._llcrypt registered [12347.804782] Key type .llcrypt registered [12350.055027] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 12:07:29 (1785946049) [12406.819437] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12406.915383] alg: No test for adler32 (adler32-zlib) [12408.252990] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [12408.627125] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [12410.360187] Key type lgssc registered [12412.307566] Lustre: Echo OBD driver; http://www.lustre.org/ [12476.761805] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12486.801599] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12535.608620] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12579.789644] Key type lgssc unregistered [12580.245784] LNet: 203620:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12580.266102] LNetError: 203620:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12580.292913] LNet: Removed LNI 192.168.203.20@tcp [12581.669286] Key type .llcrypt unregistered [12581.675881] Key type ._llcrypt unregistered [12605.819376] Key type ._llcrypt registered [12605.823375] Key type .llcrypt registered [12607.984342] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 12:11:47 (1785946307) [12611.715320] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12611.868753] alg: No test for adler32 (adler32-zlib) [12612.846636] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [12613.205162] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [12615.052909] Key type lgssc registered [12617.228553] Lustre: Echo OBD driver; http://www.lustre.org/ [12695.971652] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12705.577413] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12738.256585] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12743.026429] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [12763.633167] Lustre: lustre-MDT0000-mdc-ffff8a02c9aeb000: Connection to lustre-MDT0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [12773.886851] Lustre: lustre-MDT0001-mdc-ffff8a02c9aeb000: Connection to lustre-MDT0001 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [12784.936932] Lustre: 204610:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1785946470/real 1785946470] req@00000000f66a49bd x1872700443280256/t0(0) o400->MGC192.168.203.120@tcp@192.168.203.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1785946486 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [12784.990277] LustreError: MGC192.168.203.120@tcp: Connection to MGS (at 192.168.203.120@tcp) was lost; in progress operations using this service will fail [12809.704295] Lustre: Evicted from MGS (at 192.168.203.120@tcp) after server handle changed from 0x5c32a72f6cf3f717 to 0x5c32a72f6cf412f4 [12809.719626] Lustre: MGC192.168.203.120@tcp: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [12844.553059] LustreError: lustre-MDT0000-mdc-ffff8a02c9aeb000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [12844.585040] Lustre: lustre-MDT0000-mdc-ffff8a02c9aeb000: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [12853.551215] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12855.702939] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [12864.438170] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12866.975323] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [12870.646250] Lustre: Unmounted lustre-client [12912.738237] Key type lgssc unregistered [12913.115596] LNet: 208585:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12913.123272] LNetError: 208585:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12913.161219] LNet: Removed LNI 192.168.203.20@tcp [12913.930134] Key type .llcrypt unregistered [12913.932507] Key type ._llcrypt unregistered [12934.784245] Key type ._llcrypt registered [12934.788665] Key type .llcrypt registered [12936.830468] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 12:17:16 (1785946636) [12940.451443] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12940.740874] alg: No test for adler32 (adler32-zlib) [12942.058238] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [12942.387669] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [12944.240285] Key type lgssc registered [12945.921453] Lustre: Echo OBD driver; http://www.lustre.org/ [13007.064850] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13013.594652] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13098.535995] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13107.037241] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13154.972989] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13186.172690] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13231.957928] Key type lgssc unregistered [13232.308843] LNet: 213894:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13232.318424] LNetError: 213894:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13232.341588] LNet: Removed LNI 192.168.203.20@tcp [13233.518379] Key type .llcrypt unregistered [13233.522454] Key type ._llcrypt unregistered [13296.127376] Key type ._llcrypt registered [13296.133088] Key type .llcrypt registered [13299.686954] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 12:23:17 (1785946997) [13356.013622] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13356.275008] alg: No test for adler32 (adler32-zlib) [13357.882146] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [13358.393195] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [13360.184155] Key type lgssc registered [13362.542783] Lustre: Echo OBD driver; http://www.lustre.org/ [13491.812589] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13498.948185] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13532.035281] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13593.758469] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 12:28:13 (1785947293) [13607.316945] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 12:28:26 (1785947306) [13656.970562] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13665.830556] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13694.798815] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13696.767940] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [13706.314888] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [13710.394246] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [13713.947578] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [13715.589679] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [13722.618360] Lustre: lustre-MDT0000-mdc-ffff8a02d2181800: Connection to lustre-MDT0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [13738.976311] Lustre: 215796:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1785947424/real 1785947424] req@00000000ad4f8442 x1872701224397440/t0(0) o400->MGC192.168.203.120@tcp@192.168.203.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1785947440 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [13739.020909] LustreError: MGC192.168.203.120@tcp: Connection to MGS (at 192.168.203.120@tcp) was lost; in progress operations using this service will fail [13749.238793] Lustre: Evicted from MGS (at 192.168.203.120@tcp) after server handle changed from 0xd56720dcef818049 to 0xd56720dcef8182b8 [13749.268813] Lustre: MGC192.168.203.120@tcp: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [13751.958745] Lustre: lustre-MDT0000-mdc-ffff8a02d2181800: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [13767.561097] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13770.742309] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [13777.834664] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [13785.095571] Lustre: lustre-MDT0000-mdc-ffff8a02d2181800: Connection to lustre-MDT0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [13801.440365] Lustre: 215797:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1785947487/real 1785947487] req@000000009ef5a5bd x1872701224407680/t0(0) o400->MGC192.168.203.120@tcp@192.168.203.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1785947503 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [13801.472675] LustreError: MGC192.168.203.120@tcp: Connection to MGS (at 192.168.203.120@tcp) was lost; in progress operations using this service will fail [13811.717382] Lustre: Evicted from MGS (at 192.168.203.120@tcp) after server handle changed from 0xd56720dcef8182b8 to 0xd56720dcef8185c8 [13811.745683] Lustre: MGC192.168.203.120@tcp: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [13814.941201] Lustre: lustre-MDT0000-mdc-ffff8a02d2181800: Connection restored to 192.168.203.120@tcp (at 192.168.203.120@tcp) [13828.373304] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13831.006850] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [13837.089038] Lustre: Unmounted lustre-client [13919.699357] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13926.777647] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13954.394420] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13960.763267] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [13964.988166] Lustre: Unmounted lustre-client [13999.678687] Key type lgssc unregistered [14000.230681] LNet: 226400:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14000.240738] LNetError: 226400:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14000.280354] LNet: Removed LNI 192.168.203.20@tcp [14001.526706] Key type .llcrypt unregistered [14001.530783] Key type ._llcrypt unregistered [14021.924825] Key type ._llcrypt registered [14021.928690] Key type .llcrypt registered [14023.370581] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 12:35:23 (1785947723) [14029.972724] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14030.100322] alg: No test for adler32 (adler32-zlib) [14031.502380] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [14031.861777] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [14033.779355] Key type lgssc registered [14036.840162] Lustre: Echo OBD driver; http://www.lustre.org/ [14107.186533] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14114.316363] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14142.388433] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14144.440180] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [14152.185991] Lustre: Unmounted lustre-client [14241.226781] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14249.251887] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14278.137811] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14278.999938] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [14289.793130] Lustre: Unmounted lustre-client [14390.686989] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14398.847441] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14428.663189] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14429.685295] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [14434.060409] Lustre: Unmounted lustre-client [14483.156697] Key type lgssc unregistered [14483.507664] LNet: 233469:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14483.516537] LNetError: 233469:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14483.543570] LNet: Removed LNI 192.168.203.20@tcp [14484.343635] Key type .llcrypt unregistered [14484.346835] Key type ._llcrypt unregistered [14518.545376] Key type ._llcrypt registered [14518.552564] Key type .llcrypt registered [14520.332179] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 12:43:40 (1785948220) [14524.306932] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14524.361700] alg: No test for adler32 (adler32-zlib) [14525.458466] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [14525.665466] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [14527.368182] Key type lgssc registered [14529.450268] Lustre: Echo OBD driver; http://www.lustre.org/ [14587.483932] Key type lgssc unregistered [14587.805489] LNet: 235799:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14587.813949] LNetError: 235799:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14587.838098] LNet: Removed LNI 192.168.203.20@tcp [14588.872642] Key type .llcrypt unregistered [14588.877898] Key type ._llcrypt unregistered [14626.398075] Key type ._llcrypt registered [14626.399515] Key type .llcrypt registered [14627.222351] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14627.235989] alg: No test for adler32 (adler32-zlib) [14628.340605] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [14628.680636] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [14630.457095] Key type lgssc registered [14632.441352] Lustre: Echo OBD driver; http://www.lustre.org/ [14746.691553] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14754.259324] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14783.119731] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14832.081281] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [14834.297626] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 12:48:54 (1785948534) [14883.349690] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14891.731440] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14918.551922] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14955.797109] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14957.885897] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [14963.218882] Lustre: lustre-OST0001-osc-ffff8a02c31d4000: Connection to lustre-OST0001 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [14972.516680] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [14983.044305] Lustre: Unmounted lustre-client [15027.857450] Key type lgssc unregistered [15028.297957] LNet: 242934:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15028.307485] LNetError: 242934:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15028.345357] LNet: Removed LNI 192.168.203.20@tcp [15029.333616] Key type .llcrypt unregistered [15029.335495] Key type ._llcrypt unregistered [15079.682237] Key type ._llcrypt registered [15079.685649] Key type .llcrypt registered [15081.577654] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 12:53:01 (1785948781) [15100.337963] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15100.411580] alg: No test for adler32 (adler32-zlib) [15101.631568] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [15101.917147] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [15103.744157] Key type lgssc registered [15106.079558] Lustre: Echo OBD driver; http://www.lustre.org/ [15187.950164] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15196.335062] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15226.650397] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 12:55:26 (1785948926) [15270.195481] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15277.327122] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15307.063253] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15309.877921] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [15323.643018] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [15330.490050] Lustre: Unmounted lustre-client [15463.873215] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15470.461662] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15528.291902] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15529.099995] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [15534.000049] Lustre: Unmounted lustre-client [15584.921926] Key type lgssc unregistered [15585.277227] LNet: 250649:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15585.295836] LNetError: 250649:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15585.313686] LNet: Removed LNI 192.168.203.20@tcp [15586.296217] Key type .llcrypt unregistered [15586.301156] Key type ._llcrypt unregistered [15630.643228] Key type ._llcrypt registered [15630.645193] Key type .llcrypt registered [15631.267130] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15631.297031] alg: No test for adler32 (adler32-zlib) [15632.559676] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [15632.761611] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [15634.496165] Key type lgssc registered [15636.203643] Lustre: Echo OBD driver; http://www.lustre.org/ [15737.025956] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15744.824905] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15771.974305] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15820.848874] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [15823.069623] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 13:05:23 (1785949523) [15872.759858] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15880.238900] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15913.831213] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15919.311130] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [15923.880200] Lustre: Unmounted lustre-client [15959.194489] Key type lgssc unregistered [15959.593703] LNet: 257298:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15959.640466] LNetError: 257298:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15959.719327] LNet: Removed LNI 192.168.203.20@tcp [15960.903507] Key type .llcrypt unregistered [15960.917400] Key type ._llcrypt unregistered [15985.121191] Key type ._llcrypt registered [15985.124316] Key type .llcrypt registered [15987.878958] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [15990.159814] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 13:08:10 (1785949690) [16002.628233] Key type .llcrypt unregistered [16002.632577] Key type ._llcrypt unregistered [16015.710662] Key type ._llcrypt registered [16015.713222] Key type .llcrypt registered [16016.418332] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [16016.434193] alg: No test for adler32 (adler32-zlib) [16017.483695] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [16017.748790] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [16019.514267] Key type lgssc registered [16021.222939] Lustre: Echo OBD driver; http://www.lustre.org/ [16095.057333] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16114.869150] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [16118.676910] Lustre: Unmounted lustre-client [16145.746925] Key type lgssc unregistered [16146.120605] LNet: 260770:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16146.124319] LNetError: 260770:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16146.147116] LNet: Removed LNI 192.168.203.20@tcp [16147.298556] Key type .llcrypt unregistered [16147.302740] Key type ._llcrypt unregistered [16168.958404] Key type ._llcrypt registered [16168.960480] Key type .llcrypt registered [16169.988236] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 13:11:10 (1785949870) [16174.165373] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16174.203029] alg: No test for adler32 (adler32-zlib) [16175.514560] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [16175.869225] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [16177.649573] Key type lgssc registered [16179.697404] Lustre: Echo OBD driver; http://www.lustre.org/ [16285.598384] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16328.991228] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16336.773097] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16339.971609] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [16345.182797] Lustre: Unmounted lustre-client [16377.003411] Key type lgssc unregistered [16377.329551] LNet: 264321:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16377.346159] LNetError: 264321:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16378.414734] LNet: Removed LNI 192.168.203.20@tcp [16379.347580] Key type .llcrypt unregistered [16379.352630] Key type ._llcrypt unregistered [16401.378958] Key type ._llcrypt registered [16401.386823] Key type .llcrypt registered [16403.294547] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 13:15:03 (1785950103) [16405.883040] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16405.960142] alg: No test for adler32 (adler32-zlib) [16407.111867] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [16407.532194] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [16409.456180] Key type lgssc registered [16411.397401] Lustre: Echo OBD driver; http://www.lustre.org/ [16481.430387] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16489.770220] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16518.294640] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16520.154830] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [16525.287062] Lustre: lustre-MDT0000-mdc-ffff8a02c7891800: Connection to lustre-MDT0000 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [16527.839783] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [16527.874740] LustreError: 267485:0:(file.c:6154:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [16528.380504] LustreError: 267496:0:(file.c:6154:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [16528.392639] LustreError: 267496:0:(file.c:6154:ll_inode_revalidate_fini()) Skipped 3 previous similar messages [16528.555274] LustreError: MGC192.168.203.120@tcp: Connection to MGS (at 192.168.203.120@tcp) was lost; in progress operations using this service will fail [16528.666590] Lustre: Unmounted lustre-client [16552.901053] Key type lgssc unregistered [16553.174104] LNet: 267901:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16553.183319] LNetError: 267901:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16553.195333] LNet: Removed LNI 192.168.203.20@tcp [16553.906817] Key type .llcrypt unregistered [16553.909505] Key type ._llcrypt unregistered [16577.303224] Key type ._llcrypt registered [16577.304820] Key type .llcrypt registered [16578.907503] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 13:17:59 (1785950279) [16582.139122] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16582.359204] alg: No test for adler32 (adler32-zlib) [16583.558872] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [16583.825776] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [16585.488122] Key type lgssc registered [16587.465242] Lustre: Echo OBD driver; http://www.lustre.org/ [16664.392805] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16676.254668] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16706.150885] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16708.077848] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [16713.194265] Lustre: lustre-MDT0001-mdc-ffff8a02c7892000: Connection to lustre-MDT0001 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [16715.861882] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [16718.920865] Lustre: Unmounted lustre-client [16753.871467] Key type lgssc unregistered [16754.115788] LNet: 271495:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16754.150085] LNetError: 271495:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16754.192125] LNet: Removed LNI 192.168.203.20@tcp [16754.876601] Key type .llcrypt unregistered [16754.877869] Key type ._llcrypt unregistered [16784.753774] Key type ._llcrypt registered [16784.765633] Key type .llcrypt registered [16788.001297] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 13:21:26 (1785950486) [16817.492146] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16817.604912] alg: No test for adler32 (adler32-zlib) [16818.855970] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [16819.199764] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [16820.992809] Key type lgssc registered [16823.211539] Lustre: Echo OBD driver; http://www.lustre.org/ [16963.511974] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16966.395972] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [17023.485149] Lustre: lustre-MDT0001-mdc-ffff8a02cca53000: Connection to lustre-MDT0001 (at 192.168.203.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [17034.818815] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [17045.206096] Lustre: Unmounted lustre-client [17075.316881] Key type lgssc unregistered [17075.609036] LNet: 277296:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17075.620021] LNetError: 277296:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17075.658006] LNet: Removed LNI 192.168.203.20@tcp [17076.474828] Key type .llcrypt unregistered [17076.480861] Key type ._llcrypt unregistered [17096.059399] Key type ._llcrypt registered [17096.062220] Key type .llcrypt registered [17097.756330] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 13:26:37 (1785950797) [17100.085250] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [17102.723317] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 13:26:42 (1785950802) [17106.105332] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [17110.140588] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 13:26:48 (1785950808) [17111.707735] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [17114.629488] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 13:26:54 (1785950814) [17117.707338] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [17121.171441] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 13:27:00 (1785950820) [17123.371166] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [17125.990805] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 13:27:05 (1785950825) [17138.225546] Key type .llcrypt unregistered [17138.227526] Key type ._llcrypt unregistered [17148.735218] Key type ._llcrypt registered [17148.744892] Key type .llcrypt registered [17149.184782] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [17149.217303] alg: No test for adler32 (adler32-zlib) [17150.295716] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [17150.571696] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [17152.233158] Key type lgssc registered [17154.651298] Lustre: Echo OBD driver; http://www.lustre.org/ [17254.190082] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [17262.527960] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [17291.428576] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [17293.195983] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [17297.471299] Lustre: Unmounted lustre-client [17345.924706] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 13:30:46 (1785951046) [17396.771754] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [17405.909359] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [17458.813326] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [17460.175319] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [17464.003167] Lustre: Unmounted lustre-client [17516.258755] LNet: 1 local NIs in recovery (showing 1): 192.168.203.20@tcp [17517.556230] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 13:33:37 (1785951217) [18195.322804] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [18203.515435] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [18249.474341] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [18400.850200] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 13:48:20 (1785952100) [18417.620603] Key type lgssc unregistered [18417.961057] LNet: 290862:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [18417.980233] LNetError: 290862:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [18418.013693] LNet: Removed LNI 192.168.203.20@tcp [18418.709213] Key type .llcrypt unregistered [18418.714426] Key type ._llcrypt unregistered [18559.795120] Key type ._llcrypt registered [18559.797046] Key type .llcrypt registered [18560.597534] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [18560.642451] alg: No test for adler32 (adler32-zlib) [18562.483075] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [18563.304701] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [18565.169660] Key type lgssc registered [18566.306927] Lustre: Echo OBD driver; http://www.lustre.org/ [18682.940725] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [18691.227801] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [18722.978799] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [18765.226388] Key type lgssc unregistered [18765.685059] LNet: 294576:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [18765.713379] LNetError: 294576:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [18765.757105] LNet: Removed LNI 192.168.203.20@tcp [18767.148611] Key type .llcrypt unregistered [18767.158602] Key type ._llcrypt unregistered [18812.327322] Key type ._llcrypt registered [18812.331785] Key type .llcrypt registered [18813.916922] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 13:55:14 (1785952514) [18840.705404] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [18840.724530] alg: No test for adler32 (adler32-zlib) [18841.932477] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [18842.311995] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [18844.080162] Key type lgssc registered [18846.068305] Lustre: Echo OBD driver; http://www.lustre.org/ [18925.103215] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 13:57:05 (1785952625) [18940.877763] Key type lgssc unregistered [18941.165233] LNet: 298142:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [18941.168626] LNetError: 298142:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [18941.204780] LNet: Removed LNI 192.168.203.20@tcp [18941.803644] Key type .llcrypt unregistered [18941.807548] Key type ._llcrypt unregistered [18957.125171] Key type ._llcrypt registered [18957.135109] Key type .llcrypt registered [18957.999060] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [18958.032328] alg: No test for adler32 (adler32-zlib) [18959.414472] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [18959.942151] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [18961.768175] Key type lgssc registered [18963.122696] Lustre: Echo OBD driver; http://www.lustre.org/ [19044.016748] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [19051.418697] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [19081.452966] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [19511.561108] LNet: Added LNI 192.168.203.20@tcp50 [8/256/0/180] [19514.539387] LNet: Removed LNI 192.168.203.20@tcp [19517.120810] Lustre: 302596:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8a02c5bf8800: config has no valid NIDs, force dynamic NIDs [19518.315427] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [19518.599183] Lustre: Unmounted lustre-client [19522.044445] Key type lgssc unregistered [19522.456780] LNet: 302855:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [19522.464719] LNetError: 302855:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [19523.497259] LNet: Removed LNI 192.168.203.20@tcp50 [19524.274873] Key type .llcrypt unregistered [19524.281011] Key type ._llcrypt unregistered [19547.955044] Key type ._llcrypt registered [19547.956662] Key type .llcrypt registered [19548.896821] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [19548.964304] alg: No test for adler32 (adler32-zlib) [19550.309736] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [19550.811306] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [19552.616174] Key type lgssc registered [19554.963169] Lustre: Echo OBD driver; http://www.lustre.org/ [19623.322302] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [19630.337228] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [19641.321332] LNet: Added LNI 192.168.203.20@tcp50 [8/256/0/180] [19642.408653] LNet: Removed LNI 192.168.203.20@tcp [19643.644294] Lustre: 305554:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8a02c7897000: config has no valid NIDs, force dynamic NIDs [19644.988197] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [19645.758155] Lustre: Unmounted lustre-client [19686.786445] Key type lgssc unregistered [19687.270580] LNet: 306428:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [19687.298397] LNetError: 306428:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [19688.367468] LNet: Removed LNI 192.168.203.20@tcp50 [19689.342893] Key type .llcrypt unregistered [19689.350328] Key type ._llcrypt unregistered [19705.329412] Key type ._llcrypt registered [19705.333223] Key type .llcrypt registered [19707.333711] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 14:10:07 (1785953407) [19734.446627] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [19734.468305] alg: No test for adler32 (adler32-zlib) [19735.788447] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [19736.223953] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [19737.960202] Key type lgssc registered [19739.755718] Lustre: Echo OBD driver; http://www.lustre.org/ [19859.927797] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [19869.086864] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [19907.819640] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [19954.185825] Key type lgssc unregistered [19954.623688] LNet: 311191:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [19954.639815] LNetError: 311191:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [19954.662337] LNet: Removed LNI 192.168.203.20@tcp [19955.775669] Key type .llcrypt unregistered [19955.777371] Key type ._llcrypt unregistered [19971.394582] Key type ._llcrypt registered [19971.401314] Key type .llcrypt registered [19973.572048] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 14:14:32 (1785953672) [19977.214733] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [19977.301346] alg: No test for adler32 (adler32-zlib) [19978.552615] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [19978.973444] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [19980.808246] Key type lgssc registered [19982.857862] Lustre: Echo OBD driver; http://www.lustre.org/ [20054.755963] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [20062.649616] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [20095.441476] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [20098.338686] Lustre: Mounted lustre-client - version 2.17.56_50_g82e980f [20193.159455] Lustre: Mounted fs15246-client - version 2.17.56_50_g82e980f [20215.507313] Lustre: Unmounted fs15246-client [20251.874144] Lustre: Unmounted lustre-client [20293.102868] Key type lgssc unregistered [20293.545740] LNet: 316088:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [20293.554463] LNetError: 316088:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [20293.588866] LNet: Removed LNI 192.168.203.20@tcp [20294.822874] Key type .llcrypt unregistered [20294.826137] Key type ._llcrypt unregistered [20317.845926] Key type ._llcrypt registered [20317.849238] Key type .llcrypt registered [20321.417409] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 14:20:19 (1785954019) [20325.624730] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [20325.660128] alg: No test for adler32 (adler32-zlib) [20326.982577] Lustre: Lustre: Build Version: 2.17.56_50_g82e980f [20327.542361] LNet: Added LNI 192.168.203.20@tcp [8/256/0/180] [20329.346325] Key type lgssc registered [20331.425949] Lustre: Echo OBD driver; http://www.lustre.org/ [20535.424214] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [20545.257809] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [20579.860386] Lustre: DEBUG MARKER: oleg320-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [20716.347373] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 20290 sec ========= 14:26:55 (1785954415) [20719.133283] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 14:26:58 (1785954418) === [20724.988074] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 14:27:04 (1785954424) === [20771.416861] Key type lgssc unregistered [20771.786165] LNet: 325380:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [20771.806111] LNetError: 325380:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [20771.839362] LNet: Removed LNI 192.168.203.20@tcp [20772.783146] Key type .llcrypt unregistered [20772.788478] Key type ._llcrypt unregistered