[ 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 439611728 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001012] APIC: Switch to symmetric I/O mode setup [ 0.002370] x2apic enabled [ 0.003009] Switched APIC routing to physical x2apic. [ 0.004009] kvm-guest: setup PV IPIs [ 0.007419] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009015] pid_max: default: 32768 minimum: 301 [ 0.010144] LSM: Security Framework initializing [ 0.011051] Yama: becoming mindful. [ 0.011764] SELinux: Initializing. [ 0.012058] *** VALIDATE selinux *** [ 0.021566] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027502] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028214] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029128] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030123] *** VALIDATE tmpfs *** [ 0.032392] *** VALIDATE proc *** [ 0.033160] *** VALIDATE cgroup *** [ 0.034009] *** VALIDATE cgroup2 *** [ 0.036161] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037149] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039047] Spectre V2 : User space: Vulnerable [ 0.040011] Speculative Store Bypass: Vulnerable [ 0.043420] debug: unmapping init [mem 0xffffffffb3459000-0xffffffffb3460fff] [ 0.045201] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046734] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047028] ... version: 2 [ 0.048012] ... bit width: 48 [ 0.049013] ... generic registers: 4 [ 0.050015] ... value mask: 0000ffffffffffff [ 0.051015] ... max period: 00007fffffffffff [ 0.052015] ... fixed-purpose events: 3 [ 0.053014] ... event mask: 000000070000000f [ 0.054310] rcu: Hierarchical SRCU implementation. [ 0.056229] smp: Bringing up secondary CPUs ... [ 0.057416] x86: Booting SMP configuration: [ 0.058032] .... node #0, CPUs: #1 #2 #3 [ 0.061100] smp: Brought up 1 node, 4 CPUs [ 0.062993] smpboot: Max logical packages: 1 [ 0.063011] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.151184] node 0 deferred pages initialised in 82ms [ 0.154567] devtmpfs: initialized [ 0.156256] x86/mm: Memory block size: 128MB [ 0.158915] gcov: version magic: 0x41383552 [ 0.162405] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.163074] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.164249] pinctrl core: initialized pinctrl subsystem [ 0.165210] [ 0.165774] ************************************************************* [ 0.166012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.167012] ** ** [ 0.168014] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.169028] ** ** [ 0.170014] ** This means that this kernel is built to expose internal ** [ 0.171014] ** IOMMU data structures, which may compromise security on ** [ 0.172017] ** your system. ** [ 0.173013] ** ** [ 0.174011] ** If you see this message and you are not debugging the ** [ 0.175026] ** kernel, report this immediately to your vendor! ** [ 0.176031] ** ** [ 0.177023] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.178015] ************************************************************* [ 0.180000] NET: Registered protocol family 16 [ 0.181472] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.184062] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.186064] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.190032] cpuidle: using governor menu [ 0.192333] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.195441] PCI: Using configuration type 1 for base access [ 0.197122] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.208110] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.210027] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.213114] cryptd: max_cpu_qlen set to 1000 [ 0.216261] ACPI: Added _OSI(Module Device) [ 0.218012] ACPI: Added _OSI(Processor Device) [ 0.219015] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.220000] ACPI: Added _OSI(Processor Aggregator Device) [ 0.224145] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.229324] ACPI: Interpreter enabled [ 0.231066] ACPI: PM: (supports S0 S3 S4 S5) [ 0.232013] ACPI: Using IOAPIC for interrupt routing [ 0.234119] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.238428] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.248000] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.251062] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.253021] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.257086] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.261295] acpiphp: Slot [2] registered [ 0.263169] acpiphp: Slot [5] registered [ 0.265117] acpiphp: Slot [6] registered [ 0.266104] acpiphp: Slot [3] registered [ 0.268102] acpiphp: Slot [4] registered [ 0.269115] acpiphp: Slot [7] registered [ 0.271091] acpiphp: Slot [8] registered [ 0.272089] acpiphp: Slot [9] registered [ 0.273130] acpiphp: Slot [10] registered [ 0.275080] acpiphp: Slot [11] registered [ 0.276140] acpiphp: Slot [12] registered [ 0.278125] acpiphp: Slot [13] registered [ 0.280125] acpiphp: Slot [14] registered [ 0.281104] acpiphp: Slot [15] registered [ 0.283099] acpiphp: Slot [16] registered [ 0.284105] acpiphp: Slot [17] registered [ 0.286106] acpiphp: Slot [18] registered [ 0.287129] acpiphp: Slot [19] registered [ 0.289104] acpiphp: Slot [20] registered [ 0.291126] acpiphp: Slot [21] registered [ 0.293138] acpiphp: Slot [22] registered [ 0.295116] acpiphp: Slot [23] registered [ 0.296093] acpiphp: Slot [24] registered [ 0.298146] acpiphp: Slot [25] registered [ 0.299105] acpiphp: Slot [26] registered [ 0.301131] acpiphp: Slot [27] registered [ 0.303162] acpiphp: Slot [28] registered [ 0.304106] acpiphp: Slot [29] registered [ 0.306130] acpiphp: Slot [30] registered [ 0.307129] acpiphp: Slot [31] registered [ 0.309091] PCI host bridge to bus 0000:00 [ 0.311031] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.313037] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.316037] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.319039] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.322034] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.325040] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.327212] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.330143] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.333515] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.341023] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.346063] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.349030] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.352025] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.355027] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.358586] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.361893] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.364060] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.367984] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.372018] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.381688] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.386021] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.392988] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.400023] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.407026] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.424997] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.435490] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.442021] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.449022] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.462038] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.472904] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.476512] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.478400] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.480437] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.483283] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.488146] iommu: Default domain type: Passthrough [ 0.490488] SCSI subsystem initialized [ 0.492163] ACPI: bus type USB registered [ 0.494110] usbcore: registered new interface driver usbfs [ 0.496085] usbcore: registered new interface driver hub [ 0.498117] usbcore: registered new device driver usb [ 0.500168] pps_core: LinuxPPS API ver. 1 registered [ 0.502012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.505085] PTP clock support registered [ 0.507178] EDAC MC: Ver: 3.0.0 [ 0.509490] PCI: Using ACPI for IRQ routing [ 0.511968] NetLabel: Initializing [ 0.514022] NetLabel: domain hash size = 128 [ 0.515015] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.517133] NetLabel: unlabeled traffic allowed by default [ 0.520224] vgaarb: loaded [ 0.522363] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.524021] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.530000] clocksource: Switched to clocksource kvm-clock [ 0.647111] VFS: Disk quotas dquot_6.6.0 [ 0.649495] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.652744] *** VALIDATE ramfs *** [ 0.654273] *** VALIDATE hugetlbfs *** [ 0.656502] pnp: PnP ACPI init [ 0.659347] pnp: PnP ACPI: found 6 devices [ 0.678814] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.681860] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.684160] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.686432] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.689163] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.691458] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.694350] NET: Registered protocol family 2 [ 0.696866] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.701918] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.707359] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.712887] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.716735] TCP: Hash tables configured (established 65536 bind 65536) [ 0.719305] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.722182] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.724641] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.727278] NET: Registered protocol family 1 [ 0.729586] RPC: Registered named UNIX socket transport module. [ 0.731426] RPC: Registered udp transport module. [ 0.732933] RPC: Registered tcp transport module. [ 0.734453] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.736521] NET: Registered protocol family 44 [ 0.738537] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.740813] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.743150] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.745593] PCI: CLS 0 bytes, default 64 [ 0.747449] Unpacking initramfs... [ 2.141397] debug: unmapping init [mem 0xffff9a8e7cc64000-0xffff9a8e7ffcffff] [ 2.145448] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.147617] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.150512] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.670227] Initialise system trusted keyrings [ 2.672708] Key type blacklist registered [ 2.674928] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.684065] zbud: loaded [ 2.687084] *** VALIDATE nfs *** [ 2.688539] *** VALIDATE nfs4 *** [ 2.690453] pstore: using deflate compression [ 2.693976] Platform Keyring initialized [ 2.802347] NET: Registered protocol family 38 [ 2.804143] Key type asymmetric registered [ 2.805708] Asymmetric key parser 'x509' registered [ 2.807465] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.811479] io scheduler mq-deadline registered [ 2.813766] io scheduler kyber registered [ 2.815984] io scheduler bfq registered [ 2.819444] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.823651] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.828149] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.831363] ACPI: Power Button [PWRF] [ 2.837300] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.842963] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.853358] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.879864] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.907861] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.912460] Non-volatile memory driver v1.3 [ 2.914307] Linux agpgart interface v0.103 [ 2.951175] virtio_blk virtio1: [vda] 147232 512-byte logical blocks (75.4 MB/71.9 MiB) [ 2.954673] vda: detected capacity change from 0 to 75382784 [ 2.980311] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.983564] vdb: detected capacity change from 0 to 1073741824 [ 3.004820] libphy: Fixed MDIO Bus: probed [ 3.010483] usbcore: registered new interface driver usbserial_generic [ 3.013317] usbserial: USB Serial support registered for generic [ 3.016446] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.020944] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.022138] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.023889] mousedev: PS/2 mouse device common for all mice [ 3.026978] rtc_cmos 00:05: RTC can wake from S4 [ 3.029371] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.031060] rtc_cmos 00:05: registered as rtc0 [ 3.034457] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.037139] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.037790] intel_pstate: CPU model not supported [ 3.043640] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.047611] hid: raw HID events driver (C) Jiri Kosina [ 3.049365] usbcore: registered new interface driver usbhid [ 3.050866] usbhid: USB HID core driver [ 3.052588] drop_monitor: Initializing network drop monitor service [ 3.054418] Initializing XFRM netlink socket [ 3.055955] NET: Registered protocol family 10 [ 3.058242] Segment Routing with IPv6 [ 3.059318] NET: Registered protocol family 17 [ 3.061095] mpls_gso: MPLS GSO support [ 3.066337] RAS: Correctable Errors collector initialized. [ 3.069096] AVX version of gcm_enc/dec engaged. [ 3.070941] AES CTR mode by8 optimization enabled [ 3.146448] sched_clock: Marking stable (3146428333, 0)->(4090572760, -944144427) [ 3.150491] registered taskstats version 1 [ 3.152746] Loading compiled-in X.509 certificates [ 3.155774] zswap: loaded using pool lzo/zbud [ 3.185152] Key type big_key registered [ 3.198944] Key type encrypted registered [ 3.200864] ima: No TPM chip found, activating TPM-bypass! [ 3.203307] ima: Allocated hash algorithm: sha1 [ 3.205114] ima: No architecture policies found [ 3.207209] evm: Initialising EVM extended attributes: [ 3.209561] evm: security.selinux [ 3.211045] evm: security.ima [ 3.212449] evm: security.capability [ 3.213976] evm: HMAC attrs: 0x1 [ 3.216843] rtc_cmos 00:05: setting system clock to 2026-09-11 10:45:44 UTC (1789123544) [ 3.223525] debug: unmapping init [mem 0xffffffffb4403000-0xffffffffb45fffff] [ 3.227025] debug: unmapping init [mem 0xffffffffb3182000-0xffffffffb3458fff] [ 3.235126] Write protecting the kernel read-only data: 28672k [ 3.240283] debug: unmapping init [mem 0xffffffffb1803000-0xffffffffb19fffff] [ 3.243522] debug: unmapping init [mem 0xffffffffb2114000-0xffffffffb21fffff] [ 3.289756] 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.301275] systemd[1]: Detected virtualization kvm. [ 3.303300] systemd[1]: Detected architecture x86-64. [ 3.305149] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.333425] systemd[1]: No hostname configured. [ 3.335525] systemd[1]: Set hostname to . [ 3.337773] random: systemd: uninitialized urandom read (16 bytes read) [ 3.339955] systemd[1]: Initializing machine ID from random generator. [ 3.392147] random: ln: uninitialized urandom read (6 bytes read) [ 3.492514] random: systemd: uninitialized urandom read (16 bytes read) [ 3.495486] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.499781] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.524030] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Local File Systems. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket. Starting Create Volatile Files and Directories... Starting Journal Service... Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Reached target Swap. [ OK ] Reached target Paths. [ OK ] Reached target Timers. [ OK ] Listening on udev Control Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Sockets. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.196078] device-mapper: uevent: version 1.0.3 [ 4.197976] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 5.042306] virtio_net virtio0 ens2: renamed from eth0 [ 5.050164] random: fast init done [ 5.111554] scsi host0: ata_piix [ 5.115656] scsi host1: ata_piix [ 5.117427] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.121146] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.448516] dracut-initqueue[590]: RTNETLINK answers: File exists [ 9.720230] random: crng init done [ 9.721256] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 10.200994] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Sockets. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.471828] printk: systemd: 24 output lines suppressed due to ratelimiting [ 11.750444] SELinux: Disabled at runtime. [ 11.820483] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.826943] systemd[1]: Detected virtualization kvm. [ 11.828936] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.344176] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.347373] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.353466] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.358506] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.362295] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.372921] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.388118] systemd[1]: Listening on initctl Compatibility Named Pipe. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-sshd\x2dkeygen.slice. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Control Socket. [ OK ] Stopped target Switch Root. [ OK ] Reached target rpc_pipefs.target. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Stopped target Initrd File Systems. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Mounting Huge Pages File System... [ 12.579374] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-getty.slice. [ OK ] Reached target Local Encrypted Volumes. Mounting POSIX Message Queue File System... Mounting Kernel Debug File System... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. Starting Apply Kernel Variables... [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Apply Kernel Variables. Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ 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. [ 14.258223] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 15.555766] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 15.703297] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 16.402796] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 16.458389] EDAC sbridge: Ver: 1.1.2 [ 19.803630] Key type dns_resolver registered [* ] 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)[ 20.876463] NFS: Registering the id_resolver key type [ 20.884940] Key type id_resolver registered [ 20.887806] Key type id_legacy registered [*** ] A start job is running for Configur…-only root support (9s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Mark the need to relabel after reboot. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started D-Bus System Message Bus. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Network Manager... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg445-client login: [ 51.126631] hrtimer: interrupt took 3881471 ns [ 87.307471] libcfs: loading out-of-tree module taints kernel. [ 87.638286] Key type ._llcrypt registered [ 87.641173] Key type .llcrypt registered [ 88.259172] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 88.278655] alg: No test for adler32 (adler32-zlib) [ 89.880771] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 90.812814] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 92.649242] Key type lgssc registered [ 94.396840] Lustre: Echo OBD driver; http://www.lustre.org/ [ 264.325316] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 269.158498] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 283.234067] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing check_logdir /tmp/testlogs/ [ 288.003947] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing yml_node [ 289.764904] Lustre: lustre-OST0000-osc-ffff9a8ec702b000: disconnect after 24s idle [ 292.717640] Lustre: DEBUG MARKER: Client: 2.17.57.138 [ 295.518334] Lustre: DEBUG MARKER: MDS: 2.17.57.138 [ 297.801368] Lustre: DEBUG MARKER: OSS: 2.17.57.138 [ 299.564216] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Sep 11 06:50:39 EDT 2026 [ 316.855283] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 318.284304] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 320.919591] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 331.226460] Lustre: Unmounted lustre-client [ 448.655680] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 455.046419] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 479.760143] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 521.381386] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 06:54:20 (1789124060) [ 524.733692] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 526.201326] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 06:54:26 (1789124066) [ 561.284546] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 567.084666] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 590.523780] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 591.153707] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 598.915318] Lustre: Unmounted lustre-client [ 629.211651] Key type lgssc unregistered [ 629.591798] LNet: 15038:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 629.598284] LNetError: 15038:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 629.626171] LNet: Removed LNI 192.168.204.45@tcp [ 630.582407] Key type .llcrypt unregistered [ 630.585663] Key type ._llcrypt unregistered [ 648.408645] Key type ._llcrypt registered [ 648.410906] Key type .llcrypt registered [ 649.765986] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 06:56:29 (1789124189) [ 651.521419] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 651.557391] alg: No test for adler32 (adler32-zlib) [ 652.695308] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 652.984420] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 654.767196] Key type lgssc registered [ 656.117507] Lustre: Echo OBD driver; http://www.lustre.org/ [ 730.669195] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 818.286432] Lustre: Unmounted lustre-client [ 845.160967] Key type lgssc unregistered [ 845.486491] LNet: 18857:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 845.496811] LNetError: 18857:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 845.535870] LNet: Removed LNI 192.168.204.45@tcp [ 846.589728] Key type .llcrypt unregistered [ 846.593431] Key type ._llcrypt unregistered [ 857.846968] Key type ._llcrypt registered [ 857.852232] Key type .llcrypt registered [ 859.031610] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 06:59:58 (1789124398) [ 861.476794] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 861.486423] alg: No test for adler32 (adler32-zlib) [ 862.607150] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 862.852923] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 864.583508] Key type lgssc registered [ 865.918945] Lustre: Echo OBD driver; http://www.lustre.org/ [ 923.745514] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 929.315049] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 951.073426] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 954.144909] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 968.548403] Lustre: Unmounted lustre-client [ 1000.667377] Key type lgssc unregistered [ 1000.877626] LNet: 22480:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1000.883730] LNetError: 22480:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1000.901970] LNet: Removed LNI 192.168.204.45@tcp [ 1001.723099] Key type .llcrypt unregistered [ 1001.727485] Key type ._llcrypt unregistered [ 1012.401733] Key type ._llcrypt registered [ 1012.405336] Key type .llcrypt registered [ 1013.807888] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 07:02:33 (1789124553) [ 1016.486503] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1016.500115] alg: No test for adler32 (adler32-zlib) [ 1017.645459] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 1017.966599] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1019.728670] Key type lgssc registered [ 1020.970862] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1072.428618] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1079.197680] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1103.421958] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1105.202751] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 1111.873124] Lustre: Unmounted lustre-client [ 1141.467720] Key type lgssc unregistered [ 1141.807755] LNet: 25677:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1141.819246] LNetError: 25677:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1141.837210] LNet: Removed LNI 192.168.204.45@tcp [ 1142.476283] Key type .llcrypt unregistered [ 1142.478271] Key type ._llcrypt unregistered [ 1157.285223] Key type ._llcrypt registered [ 1157.287951] Key type .llcrypt registered [ 1158.535852] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 07:04:58 (1789124698) [ 1160.723595] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1160.789101] alg: No test for adler32 (adler32-zlib) [ 1161.966179] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 1162.250264] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1163.943240] Key type lgssc registered [ 1165.230519] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1215.899559] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1221.506993] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1241.471933] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1243.077833] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 1248.236913] Lustre: lustre-MDT0000-mdc-ffff9a8ec80e7000: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1258.485645] Lustre: lustre-MDT0001-mdc-ffff9a8ec80e7000: Connection to lustre-MDT0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1265.839204] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1274.719362] Lustre: 26638:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789124799/real 1789124799] req@0000000088a60b73 x1876033224579200/t0(0) o400->MGC192.168.204.145@tcp@192.168.204.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1789124815 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1274.752489] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [ 1276.209883] Lustre: Unmounted lustre-client [ 1295.704162] Key type lgssc unregistered [ 1296.008945] LNet: 29338:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1296.014766] LNetError: 29338:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1296.028921] LNet: Removed LNI 192.168.204.45@tcp [ 1296.697919] Key type .llcrypt unregistered [ 1296.700114] Key type ._llcrypt unregistered [ 1313.369564] Key type ._llcrypt registered [ 1313.371733] Key type .llcrypt registered [ 1314.983520] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 07:07:34 (1789124854) [ 1318.065819] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1318.087969] alg: No test for adler32 (adler32-zlib) [ 1319.067607] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 1319.248864] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1321.007187] Key type lgssc registered [ 1322.424578] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1378.390682] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1384.204818] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1406.409704] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1409.494084] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 1419.752592] Lustre: lustre-OST0000-osc-ffff9a8ec403c000: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1425.080618] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1435.474223] Lustre: Unmounted lustre-client [ 1463.261934] Key type lgssc unregistered [ 1463.584844] LNet: 32955:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1463.590566] LNetError: 32955:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1463.604700] LNet: Removed LNI 192.168.204.45@tcp [ 1464.370665] Key type .llcrypt unregistered [ 1464.374550] Key type ._llcrypt unregistered [ 1481.462497] Key type ._llcrypt registered [ 1481.464331] Key type .llcrypt registered [ 1482.945192] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 07:10:22 (1789125022) [ 1485.541784] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1485.560223] alg: No test for adler32 (adler32-zlib) [ 1486.631976] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 1486.909202] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1488.607403] Key type lgssc registered [ 1490.145928] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1547.337869] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1553.471584] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1575.949262] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1577.616504] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 1584.837442] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1588.504666] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1600.215617] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-11 7h12m19s [ 1602.931469] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1608.687433] Lustre: lustre-MDT0000-mdc-ffff9a8ec57ce800: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1613.767416] LustreError: 36741:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff9a8ec57ce800: can't stat MDS #0: rc = -19 [ 1615.237391] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1627.114227] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [ 1627.138452] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0x6e4d62828bdf68ab to 0x6e4d62828bdf6b75 [ 1627.163311] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 1628.203255] LustreError: lustre-MDT0000-mdc-ffff9a8ec57ce800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1628.263312] Lustre: lustre-MDT0000-mdc-ffff9a8ec57ce800: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 1632.550564] Lustre: DEBUG MARKER: Wait for df (36741) ... [ 1634.002435] Lustre: DEBUG MARKER: done [ 1635.976726] Lustre: Unmounted lustre-client [ 1663.382768] Key type lgssc unregistered [ 1663.649862] LNet: 37762:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1663.655055] LNetError: 37762:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1663.666071] LNet: Removed LNI 192.168.204.45@tcp [ 1664.222951] Key type .llcrypt unregistered [ 1664.224659] Key type ._llcrypt unregistered [ 1695.138916] Key type ._llcrypt registered [ 1695.141269] Key type .llcrypt registered [ 1696.410790] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 07:13:56 (1789125236) [ 1699.038172] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1699.397246] alg: No test for adler32 (adler32-zlib) [ 1700.558219] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 1700.873322] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1702.599219] Key type lgssc registered [ 1703.964778] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1758.919725] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1764.746549] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1788.068270] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1790.837733] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 1795.863816] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-11 7h15m35s [ 1797.579456] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1805.177811] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1807.582480] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1827.807155] Lustre: 41907:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789125348/real 1789125348] req@0000000066c2918a x1876033789762304/t0(0) o101->lustre-MDT0000-mdc-ffff9a8ed1390000@192.168.204.145@tcp:12/10 lens 576/1152 e 0 to 1 dl 1789125368 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1827.834892] Lustre: lustre-MDT0000-mdc-ffff9a8ed1390000: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1827.874707] Lustre: lustre-MDT0000-mdc-ffff9a8ed1390000: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 1849.677632] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1853.306817] Lustre: DEBUG MARKER: done [ 1858.266334] Lustre: Unmounted lustre-client [ 1893.338836] Key type lgssc unregistered [ 1893.548691] LNet: 42796:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1893.555907] LNetError: 42796:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1893.569229] LNet: Removed LNI 192.168.204.45@tcp [ 1894.263493] Key type .llcrypt unregistered [ 1894.269728] Key type ._llcrypt unregistered [ 1922.271864] Key type ._llcrypt registered [ 1922.275636] Key type .llcrypt registered [ 1923.925610] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 07:17:43 (1789125463) [ 1925.481834] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1927.471852] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 07:17:47 (1789125467) [ 1931.578948] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1931.625207] alg: No test for adler32 (adler32-zlib) [ 1932.764450] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 1932.990249] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 1934.655179] Key type lgssc registered [ 1935.837432] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1962.569907] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 07:18:22 (1789125502) [ 1996.130590] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2001.546476] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2021.879356] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2024.587037] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 2027.985567] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2031.280022] Lustre: Unmounted lustre-client [ 2041.432376] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2092.898719] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2099.030932] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2099.651748] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 2103.881758] Lustre: Unmounted lustre-client [ 2170.726399] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2178.613995] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2179.573469] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 2185.206616] Lustre: Unmounted lustre-client [ 2207.008627] Lustre: DEBUG MARKER: files compared the same [ 2230.001780] Key type lgssc unregistered [ 2230.315160] LNet: 50432:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2230.327829] LNetError: 50432:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2230.354793] LNet: Removed LNI 192.168.204.45@tcp [ 2231.199619] Key type .llcrypt unregistered [ 2231.201555] Key type ._llcrypt unregistered [ 2245.588195] Key type ._llcrypt registered [ 2245.590153] Key type .llcrypt registered [ 2246.927805] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 07:23:06 (1789125786) [ 2249.173833] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2249.266992] alg: No test for adler32 (adler32-zlib) [ 2250.348318] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 2250.646748] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 2252.367160] Key type lgssc registered [ 2253.636300] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2304.835676] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2311.611669] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2332.107811] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2334.757558] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 2341.897561] Lustre: Unmounted lustre-client [ 2376.870446] Key type lgssc unregistered [ 2377.186975] LNet: 54021:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2377.203504] LNetError: 54021:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2377.253726] LNet: Removed LNI 192.168.204.45@tcp [ 2377.884362] Key type .llcrypt unregistered [ 2377.887509] Key type ._llcrypt unregistered [ 2393.648628] Key type ._llcrypt registered [ 2393.652174] Key type .llcrypt registered [ 2395.702516] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 07:25:34 (1789125934) [ 2398.543802] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2398.579507] alg: No test for adler32 (adler32-zlib) [ 2399.681766] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 2399.982238] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 2401.727228] Key type lgssc registered [ 2403.664751] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2490.338745] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2524.848154] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2530.685812] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2558.565463] Key type lgssc unregistered [ 2558.945586] LNet: 57514:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2558.954122] LNetError: 57514:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2558.977024] LNet: Removed LNI 192.168.204.45@tcp [ 2559.811514] Key type .llcrypt unregistered [ 2559.813356] Key type ._llcrypt unregistered [ 2577.365195] Key type ._llcrypt registered [ 2577.367350] Key type .llcrypt registered [ 2578.695398] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 07:28:38 (1789126118) [ 2582.288155] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2582.377981] alg: No test for adler32 (adler32-zlib) [ 2583.619645] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 2583.946439] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 2585.623246] Key type lgssc registered [ 2586.901651] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2667.475751] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 2675.089579] Lustre: Unmounted lustre-client [ 2714.855868] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 07:30:54 (1789126254) [ 2850.786306] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2867.712710] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 2875.478458] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2875.488614] LustreError: 63992:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff9a8ec9089800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2875.530623] Lustre: 58501:0:(llite_lib.c:4366:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.145@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2885.919298] Lustre: Unmounted lustre-client [ 2945.350675] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 07:34:45 (1789126485) [ 2959.317932] Key type lgssc unregistered [ 2959.637871] LNet: 65215:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2959.643711] LNetError: 65215:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2959.662231] LNet: Removed LNI 192.168.204.45@tcp [ 2960.392549] Key type .llcrypt unregistered [ 2960.394638] Key type ._llcrypt unregistered [ 2971.586096] Key type ._llcrypt registered [ 2971.591644] Key type .llcrypt registered [ 2972.029365] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2972.038108] alg: No test for adler32 (adler32-zlib) [ 2973.128297] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 2973.520509] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 2975.335146] Key type lgssc registered [ 2976.890757] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3034.781128] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3041.293853] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3066.403058] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3068.114397] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 3071.886397] Lustre: Unmounted lustre-client [ 3099.593823] Key type lgssc unregistered [ 3099.920207] LNet: 68234:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3099.943878] LNetError: 68234:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3099.962604] LNet: Removed LNI 192.168.204.45@tcp [ 3100.787163] Key type .llcrypt unregistered [ 3100.788865] Key type ._llcrypt unregistered [ 3113.842540] Key type ._llcrypt registered [ 3113.847528] Key type .llcrypt registered [ 3114.351956] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3114.360877] alg: No test for adler32 (adler32-zlib) [ 3115.472701] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 3115.809769] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3117.593127] Key type lgssc registered [ 3118.988881] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3226.098792] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3231.031782] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3252.457980] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3254.511739] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 3257.280324] Lustre: Unmounted lustre-client [ 3288.932283] Key type lgssc unregistered [ 3289.226422] LNet: 71685:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3289.243287] LNetError: 71685:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3289.263269] LNet: Removed LNI 192.168.204.45@tcp [ 3290.134789] Key type .llcrypt unregistered [ 3290.143597] Key type ._llcrypt unregistered [ 3307.996933] Key type ._llcrypt registered [ 3307.999572] Key type .llcrypt registered [ 3309.962654] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 07:40:49 (1789126849) [ 3312.344894] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3312.459837] alg: No test for adler32 (adler32-zlib) [ 3313.602427] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 3313.963910] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3315.719351] Key type lgssc registered [ 3316.939452] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3370.103188] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3375.475986] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3392.934253] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3394.615716] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 3399.321441] Lustre: Unmounted lustre-client [ 3399.784388] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 3402.693964] Lustre: Unmounted lustre-client [ 3435.198819] Key type lgssc unregistered [ 3435.445461] LNet: 75377:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3435.454338] LNetError: 75377:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3435.486618] LNet: Removed LNI 192.168.204.45@tcp [ 3436.199798] Key type .llcrypt unregistered [ 3436.201732] Key type ._llcrypt unregistered [ 3445.830119] Key type ._llcrypt registered [ 3445.833051] Key type .llcrypt registered [ 3446.187523] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3446.202992] alg: No test for adler32 (adler32-zlib) [ 3447.252552] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 3447.461939] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3449.200439] Key type lgssc registered [ 3450.563800] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3500.277249] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3506.003972] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3525.432910] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3526.927153] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 3530.563288] Lustre: Unmounted lustre-client [ 3557.696435] Key type lgssc unregistered [ 3557.905233] LNet: 78412:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3557.916837] LNetError: 78412:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3557.941198] LNet: Removed LNI 192.168.204.45@tcp [ 3558.563481] Key type .llcrypt unregistered [ 3558.565320] Key type ._llcrypt unregistered [ 3571.573533] Key type ._llcrypt registered [ 3571.574869] Key type .llcrypt registered [ 3572.904977] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 07:45:12 (1789127112) [ 3574.874045] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3574.888676] alg: No test for adler32 (adler32-zlib) [ 3575.887873] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 3576.162960] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3577.921061] Key type lgssc registered [ 3579.031652] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3629.507299] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3635.572964] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3659.667425] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3662.427714] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 3671.813415] Lustre: lustre: root_squash is set to 0:0 [ 3680.819374] Lustre: lustre: nosquash_nids is cleared [ 3680.849707] Lustre: lustre: root_squash is set to 500:500 [ 3686.641077] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.45@tcp 192.168.0.[2,10]@tcp [ 3694.088774] Lustre: lustre: nosquash_nids set to 192.168.204.45/24@tcp [ 3698.828478] Lustre: Unmounted lustre-client [ 3727.140669] Key type lgssc unregistered [ 3727.501025] LNet: 82335:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3727.515469] LNetError: 82335:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3727.527382] LNet: Removed LNI 192.168.204.45@tcp [ 3728.349911] Key type .llcrypt unregistered [ 3728.354915] Key type ._llcrypt unregistered [ 3745.881835] Key type ._llcrypt registered [ 3745.883522] Key type .llcrypt registered [ 3747.221241] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 07:48:07 (1789127287) [ 3750.283104] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3752.720921] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 07:48:12 (1789127292) [ 3755.486878] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3755.546133] alg: No test for adler32 (adler32-zlib) [ 3756.751313] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 3757.068749] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3758.783290] Key type lgssc registered [ 3760.235044] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3816.858206] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3823.712995] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3846.422399] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3847.155851] Lustre: lustre: root_squash is set to 500:500 [ 3847.175934] Lustre: lustre: nosquash_nids set to 192.168.204.45/24@tcp [ 3848.243148] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 3857.370357] Lustre: Unmounted lustre-client [ 3885.837981] Key type lgssc unregistered [ 3886.081465] LNet: 86303:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3886.089757] LNetError: 86303:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3886.104755] LNet: Removed LNI 192.168.204.45@tcp [ 3886.937151] Key type .llcrypt unregistered [ 3886.943039] Key type ._llcrypt unregistered [ 3903.728280] Key type ._llcrypt registered [ 3903.732373] Key type .llcrypt registered [ 3905.217154] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3907.179437] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 07:50:46 (1789127446) [ 3926.496648] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3926.536507] alg: No test for adler32 (adler32-zlib) [ 3927.723465] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 3928.097843] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 3929.865375] Key type lgssc registered [ 3931.325150] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4017.667075] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4024.504420] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4049.230636] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4131.075717] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4138.198683] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4163.122548] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4176.483047] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 4211.026783] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9a8ed8b85000.ost_server_uuid 50 [ 4213.929531] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9a8ed8b85000.ost_server_uuid in IDLE state after 0 sec [ 4214.645303] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 4220.975742] Lustre: Unmounted lustre-client [ 4222.726952] Lustre: Unmounted lustre-client [ 4274.613982] Key type lgssc unregistered [ 4274.943053] LNet: 93982:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4274.949226] LNetError: 93982:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4274.967234] LNet: Removed LNI 192.168.204.45@tcp [ 4275.987857] Key type .llcrypt unregistered [ 4275.990921] Key type ._llcrypt unregistered [ 4312.272548] Key type ._llcrypt registered [ 4312.276502] Key type .llcrypt registered [ 4313.966253] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 07:57:33 (1789127853) [ 4334.934644] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4335.085790] alg: No test for adler32 (adler32-zlib) [ 4336.269429] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 4336.685593] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 4338.431230] Key type lgssc registered [ 4339.833578] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4432.447879] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4439.002584] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4465.484335] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4467.230718] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 4488.671915] Lustre: 95346:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789128013/real 1789128013] req@00000000ccdd5a12 x1876036552758400/t0(0) o400->lustre-OST0000-osc-ffff9a8ed1391800@192.168.204.145@tcp:28/4 lens 224/224 e 0 to 1 dl 1789128029 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4488.711431] Lustre: lustre-OST0000-osc-ffff9a8ed1391800: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4492.831550] Lustre: 95346:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789128018/real 1789128018] req@0000000038fcead8 x1876036552758912/t0(0) o400->lustre-OST0000-osc-ffff9a8ed1391800@192.168.204.145@tcp:28/4 lens 224/224 e 0 to 1 dl 1789128034 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4496.968534] Lustre: lustre-OST0000-osc-ffff9a8ed1391800: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 4497.888068] Lustre: 95347:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789128023/real 1789128023] req@0000000093354b8a x1876036552759424/t0(0) o400->lustre-OST0000-osc-ffff9a8ed1391800@192.168.204.145@tcp:28/4 lens 224/224 e 0 to 1 dl 1789128039 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4498.921309] Lustre: lustre-MDT0000-mdc-ffff9a8ed1391800: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4503.007367] Lustre: 95346:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789128028/real 1789128028] req@0000000064139df7 x1876036552759936/t0(0) o400->lustre-OST0000-osc-ffff9a8ed1391800@192.168.204.145@tcp:28/4 lens 224/224 e 0 to 1 dl 1789128044 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4519.418234] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [ 4519.434029] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0x7f57b705dd1562ec to 0x7f57b705dd156482 [ 4519.443881] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 4532.238560] Lustre: lustre-MDT0000-mdc-ffff9a8ed1391800: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 4538.587933] Lustre: Unmounted lustre-client [ 4567.171718] Key type lgssc unregistered [ 4567.496891] LNet: 99670:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4567.510982] LNetError: 99670:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4567.535304] LNet: Removed LNI 192.168.204.45@tcp [ 4568.264204] Key type .llcrypt unregistered [ 4568.269794] Key type ._llcrypt unregistered [ 4585.443314] Key type ._llcrypt registered [ 4585.445063] Key type .llcrypt registered [ 4586.815721] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 08:02:06 (1789128126) [ 4602.022861] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4602.129229] alg: No test for adler32 (adler32-zlib) [ 4603.235835] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 4603.570593] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 4605.239415] Key type lgssc registered [ 4606.426541] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4644.978632] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4750.515711] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4757.377849] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4782.294756] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4785.146105] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 4787.316457] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4789.198053] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 08:05:29 (1789128329) [ 5010.374967] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5020.714651] Lustre: Unmounted lustre-client [ 5136.548316] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5142.024372] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5163.606832] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5203.578239] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 08:12:23 (1789128743) [ 5293.844887] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5301.070307] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5329.558223] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5330.338603] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 5335.036823] Lustre: Unmounted lustre-client [ 5366.062866] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 08:15:06 (1789128906) [ 5456.008914] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5462.127821] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5483.956467] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5484.561989] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 5489.142418] Lustre: Unmounted lustre-client [ 5515.152820] Key type lgssc unregistered [ 5515.418768] LNet: 122691:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5515.433116] LNetError: 122691:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5515.452186] LNet: Removed LNI 192.168.204.45@tcp [ 5516.202645] Key type .llcrypt unregistered [ 5516.205207] Key type ._llcrypt unregistered [ 5532.422818] Key type ._llcrypt registered [ 5532.432845] Key type .llcrypt registered [ 5534.058384] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 08:17:53 (1789129073) [ 5537.029424] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5537.077201] alg: No test for adler32 (adler32-zlib) [ 5538.144427] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 5538.331329] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 5539.999184] Key type lgssc registered [ 5541.564467] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5594.508951] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5600.784706] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5624.236276] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5625.776542] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 5643.073252] Lustre: Unmounted lustre-client [ 5673.096557] Key type lgssc unregistered [ 5673.456933] LNet: 126293:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5673.480612] LNetError: 126293:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5673.535744] LNet: Removed LNI 192.168.204.45@tcp [ 5674.114683] Key type .llcrypt unregistered [ 5674.119171] Key type ._llcrypt unregistered [ 5691.129454] Key type ._llcrypt registered [ 5691.131116] Key type .llcrypt registered [ 5692.762720] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 08:20:32 (1789129232) [ 5695.267668] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5695.339607] alg: No test for adler32 (adler32-zlib) [ 5696.539945] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 5696.916285] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 5698.695965] Key type lgssc registered [ 5700.211758] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5756.136385] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5762.568115] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5784.603992] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5787.572231] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 5797.872659] Lustre: lustre-OST0000-osc-ffff9a8ee013f800: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5808.341557] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff9a8ee013f800.ost_server_uuid 50 [ 5809.808781] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5821.064670] Lustre: Unmounted lustre-client [ 5843.776158] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 08:23:03 (1789129383) [ 5878.395536] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5884.129597] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5905.929822] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5933.294335] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5933.764342] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 5939.181314] Lustre: lustre-OST0000-osc-ffff9a8ed8236800: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5966.983383] Lustre: Unmounted lustre-client [ 6017.873619] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 08:25:57 (1789129557) [ 6051.615354] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6056.590791] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6080.927571] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6104.596163] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6105.318309] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 6110.695670] Lustre: lustre-OST0000-osc-ffff9a8ec51f5000: Connection to lustre-OST0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6127.778580] Lustre: Unmounted lustre-client [ 6185.888585] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 08:28:45 (1789129725) [ 6292.439454] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6298.477483] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6323.017878] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6400.462394] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6406.303909] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6427.548782] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6460.555235] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 6501.517702] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6507.555743] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 4 sec [ 6509.849337] Lustre: Unmounted lustre-client [ 6540.206577] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 08:34:39 (1789130079) [ 6579.186116] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6585.561345] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6610.612866] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6649.502910] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6678.068181] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 6721.560679] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6723.423469] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6735.544427] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6745.912156] Lustre: Unmounted lustre-client [ 6798.712775] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 08:38:58 (1789130338) [ 6831.596274] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6838.190474] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6860.093070] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6860.835158] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 6887.302824] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6889.236529] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6905.319904] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9a8ed1947800.ost_server_uuid 50 [ 6906.836503] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9a8ed1947800.ost_server_uuid in IDLE state after 0 sec [ 6909.629618] Lustre: Unmounted lustre-client [ 6910.010557] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6910.017558] Lustre: Skipped 3 previous similar messages [ 6910.090942] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 6910.947152] LustreError: 149739:0:(sec.c:403:import_sec_validate_get()) import 00000000111b834d (NEW) with no sec [ 6974.808460] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 08:41:54 (1789130514) [ 7006.536577] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7011.729360] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7032.445151] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7055.382542] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7055.988747] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7056.139719] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 7069.062434] Lustre: Unmounted lustre-client [ 7069.064048] Lustre: Skipped 1 previous similar message [ 7107.099317] Key type lgssc unregistered [ 7107.407272] LNet: 153155:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7107.423434] LNetError: 153155:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7107.438932] LNet: Removed LNI 192.168.204.45@tcp [ 7108.395750] Key type .llcrypt unregistered [ 7108.398121] Key type ._llcrypt unregistered [ 7124.165951] Key type ._llcrypt registered [ 7124.167883] Key type .llcrypt registered [ 7125.524316] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 08:44:25 (1789130665) [ 7126.685268] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7126.710337] alg: No test for adler32 (adler32-zlib) [ 7127.852273] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 7128.123269] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 7129.799406] Key type lgssc registered [ 7130.863841] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7183.130269] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7188.300538] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7208.557300] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7228.712427] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7230.350815] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7231.580764] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 7238.161353] LustreError: lustre-MDT0001-mdc-ffff9a8ec57c9800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7238.194081] Lustre: lustre-MDT0001-mdc-ffff9a8ec57c9800: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 7243.938293] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7245.529117] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7267.344253] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7271.902165] Lustre: Unmounted lustre-client [ 7298.436839] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 08:47:18 (1789130838) [ 7398.043948] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7404.435429] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7427.017946] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7427.816144] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 7455.064876] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7456.463705] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7462.893328] Lustre: lustre-OST0001-osc-ffff9a8ec5aed000: Connection to lustre-OST0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7469.090879] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7479.477341] Lustre: Unmounted lustre-client [ 7521.148916] Key type lgssc unregistered [ 7521.393082] LNet: 162782:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7521.400439] LNetError: 162782:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7521.420380] LNet: Removed LNI 192.168.204.45@tcp [ 7522.167238] Key type .llcrypt unregistered [ 7522.169667] Key type ._llcrypt unregistered [ 7553.540784] Key type ._llcrypt registered [ 7553.542870] Key type .llcrypt registered [ 7555.216838] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 08:51:34 (1789131094) [ 7557.584973] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7557.634910] alg: No test for adler32 (adler32-zlib) [ 7558.770673] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 7559.032400] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 7560.695372] Key type lgssc registered [ 7561.756283] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7611.643747] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7617.529966] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7640.186363] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7642.809591] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 7690.270423] Lustre: Unmounted lustre-client [ 7731.546130] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7732.249392] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 7768.361672] Lustre: Unmounted lustre-client [ 7796.340968] Key type lgssc unregistered [ 7796.645833] LNet: 167238:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7796.653064] LNetError: 167238:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7797.671535] LNet: Removed LNI 192.168.204.45@tcp [ 7798.428734] Key type .llcrypt unregistered [ 7798.432221] Key type ._llcrypt unregistered [ 7813.317335] Key type ._llcrypt registered [ 7813.319444] Key type .llcrypt registered [ 7814.510954] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 08:55:54 (1789131354) [ 7816.943344] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7816.979482] alg: No test for adler32 (adler32-zlib) [ 7818.040942] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 7818.206462] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 7819.879798] Key type lgssc registered [ 7820.952679] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7874.275350] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7879.754843] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7904.801822] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7906.558519] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 7926.958436] Lustre: Unmounted lustre-client [ 7956.320431] Key type lgssc unregistered [ 7956.633929] LNet: 170998:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7956.639434] LNetError: 170998:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7956.656713] LNet: Removed LNI 192.168.204.45@tcp [ 7957.400840] Key type .llcrypt unregistered [ 7957.405176] Key type ._llcrypt unregistered [ 7970.471418] Key type ._llcrypt registered [ 7970.475417] Key type .llcrypt registered [ 7971.044428] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7971.091690] alg: No test for adler32 (adler32-zlib) [ 7972.175776] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 7972.534632] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 7974.207192] Key type lgssc registered [ 7975.672366] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8031.068068] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8036.243700] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8055.727859] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8057.278718] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 8064.501309] Lustre: Unmounted lustre-client [ 8099.177364] Key type lgssc unregistered [ 8099.461102] LNet: 174069:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8099.471979] LNetError: 174069:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8099.486936] LNet: Removed LNI 192.168.204.45@tcp [ 8100.186318] Key type .llcrypt unregistered [ 8100.194076] Key type ._llcrypt unregistered [ 8115.330633] Key type ._llcrypt registered [ 8115.332684] Key type .llcrypt registered [ 8116.862544] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 09:00:56 (1789131656) [ 8119.345434] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8119.379484] alg: No test for adler32 (adler32-zlib) [ 8120.496361] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 8120.855353] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 8122.587333] Key type lgssc registered [ 8123.774248] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8174.897720] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8180.505110] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8202.419674] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8205.136153] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 8228.245970] Lustre: Unmounted lustre-client [ 8255.196414] Key type lgssc unregistered [ 8255.406445] LNet: 177839:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8255.412983] LNetError: 177839:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8255.425938] LNet: Removed LNI 192.168.204.45@tcp [ 8255.997571] Key type .llcrypt unregistered [ 8256.001784] Key type ._llcrypt unregistered [ 8268.445145] Key type ._llcrypt registered [ 8268.446792] Key type .llcrypt registered [ 8268.632925] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8268.644958] alg: No test for adler32 (adler32-zlib) [ 8269.945531] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 8270.226232] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 8271.911223] Key type lgssc registered [ 8272.747527] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8338.012862] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8343.985070] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8364.167533] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8375.371081] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 8383.298597] Lustre: Unmounted lustre-client [ 8410.360772] Key type lgssc unregistered [ 8410.628963] LNet: 180909:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8410.640472] LNetError: 180909:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8410.672894] LNet: Removed LNI 192.168.204.45@tcp [ 8411.394731] Key type .llcrypt unregistered [ 8411.398342] Key type ._llcrypt unregistered [ 8426.772388] Key type ._llcrypt registered [ 8426.780345] Key type .llcrypt registered [ 8428.320868] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 09:06:07 (1789131967) [ 8451.808844] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8451.944523] alg: No test for adler32 (adler32-zlib) [ 8453.079642] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 8453.346253] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 8455.074908] Key type lgssc registered [ 8456.369197] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8537.804339] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8543.665551] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8565.517792] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8605.495953] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 09:09:05 (1789132145) [ 8641.066965] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8647.413609] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8671.652771] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8674.403263] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 8679.076543] Lustre: Unmounted lustre-client [ 8706.966420] Key type lgssc unregistered [ 8707.343669] LNet: 188019:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8707.351776] LNetError: 188019:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8707.370513] LNet: Removed LNI 192.168.204.45@tcp [ 8708.107601] Key type .llcrypt unregistered [ 8708.115991] Key type ._llcrypt unregistered [ 8724.612373] Key type ._llcrypt registered [ 8724.614896] Key type .llcrypt registered [ 8726.055251] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8727.744277] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 09:11:07 (1789132267) [ 8747.281482] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8747.302190] alg: No test for adler32 (adler32-zlib) [ 8748.410709] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 8748.701547] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 8750.457873] Key type lgssc registered [ 8752.045845] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8843.578229] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8848.605141] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8872.932442] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8893.466433] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8895.328648] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 8917.731937] Lustre: Unmounted lustre-client [ 9047.960640] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9052.962748] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9074.618178] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9116.389587] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 09:17:36 (1789132656) [ 9118.004981] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9119.864756] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 09:17:39 (1789132659) [ 9215.321720] Key type lgssc unregistered [ 9215.557862] LNet: 199461:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9215.565391] LNetError: 199461:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9215.591502] LNet: Removed LNI 192.168.204.45@tcp [ 9216.291788] Key type .llcrypt unregistered [ 9216.304953] Key type ._llcrypt unregistered [ 9232.125580] Key type ._llcrypt registered [ 9232.127055] Key type .llcrypt registered [ 9233.264904] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 09:19:33 (1789132773) [ 9274.721663] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9274.745918] alg: No test for adler32 (adler32-zlib) [ 9276.043682] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 9276.471962] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 9278.319657] Key type lgssc registered [ 9280.192265] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9328.528252] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9334.403334] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9366.805589] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9389.269206] Key type lgssc unregistered [ 9389.559751] LNet: 203197:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9389.572905] LNetError: 203197:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9389.596397] LNet: Removed LNI 192.168.204.45@tcp [ 9390.234581] Key type .llcrypt unregistered [ 9390.236296] Key type ._llcrypt unregistered [ 9404.635640] Key type ._llcrypt registered [ 9404.646823] Key type .llcrypt registered [ 9405.830674] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 09:22:25 (1789132945) [ 9407.886486] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9407.958436] alg: No test for adler32 (adler32-zlib) [ 9409.075971] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 9409.240262] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 9410.927186] Key type lgssc registered [ 9412.219273] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9462.856161] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9468.244798] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9487.559505] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9489.201114] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [ 9499.621465] Lustre: lustre-MDT0000-mdc-ffff9a8ed1394000: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9509.883418] Lustre: lustre-MDT0001-mdc-ffff9a8ed1394000: Connection to lustre-MDT0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9521.120097] Lustre: 204184:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789133046/real 1789133046] req@000000006afa4b3a x1876041872261120/t0(0) o400->MGC192.168.204.145@tcp@192.168.204.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1789133062 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9521.151752] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [ 9531.436704] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0xbecaecd4179a5456 to 0xbecaecd4179a6f45 [ 9531.467614] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 9555.441353] LustreError: lustre-MDT0000-mdc-ffff9a8ed1394000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9555.475433] Lustre: lustre-MDT0000-mdc-ffff9a8ed1394000: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [ 9561.783302] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9564.429739] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9571.327544] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9573.287393] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9576.769296] Lustre: Unmounted lustre-client [ 9613.753530] Key type lgssc unregistered [ 9614.018455] LNet: 208142:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9614.025314] LNetError: 208142:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9614.041113] LNet: Removed LNI 192.168.204.45@tcp [ 9614.969829] Key type .llcrypt unregistered [ 9614.973118] Key type ._llcrypt unregistered [ 9635.531843] Key type ._llcrypt registered [ 9635.533820] Key type .llcrypt registered [ 9637.225400] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 09:26:16 (1789133176) [ 9640.411386] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9640.430712] alg: No test for adler32 (adler32-zlib) [ 9641.645870] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 9641.873270] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 9643.559878] Key type lgssc registered [ 9645.349130] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9699.144413] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9705.239712] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9765.474487] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9771.275815] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9806.978814] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9829.301987] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9886.048922] Key type lgssc unregistered [ 9886.304617] LNet: 213445:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9886.321612] LNetError: 213445:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9886.358783] LNet: Removed LNI 192.168.204.45@tcp [ 9887.138799] Key type .llcrypt unregistered [ 9887.143423] Key type ._llcrypt unregistered [ 9935.140688] Key type ._llcrypt registered [ 9935.143911] Key type .llcrypt registered [ 9936.737563] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 09:31:16 (1789133476) [ 9978.061692] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9978.106714] alg: No test for adler32 (adler32-zlib) [ 9979.211331] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [ 9979.544098] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [ 9981.295703] Key type lgssc registered [ 9982.647616] Lustre: Echo OBD driver; http://www.lustre.org/ [10067.385746] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10075.124738] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10101.382513] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10151.924587] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 09:34:51 (1789133691) [10159.672328] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 09:34:59 (1789133699) [10193.776245] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10200.775337] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10225.682403] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10227.382444] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [10232.556916] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10234.431305] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10235.996748] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10238.033202] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10243.046587] Lustre: lustre-MDT0000-mdc-ffff9a8ec5709800: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [10259.359217] Lustre: 215341:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789133784/real 1789133784] req@000000004e64cf83 x1876042469876864/t0(0) o400->MGC192.168.204.145@tcp@192.168.204.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1789133800 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10259.410160] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [10259.452579] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0x5e2a8a3723387595 to 0x5e2a8a372338770f [10259.473183] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10273.290190] Lustre: lustre-MDT0000-mdc-ffff9a8ec5709800: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10282.400344] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10284.439393] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10288.476977] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10295.271049] Lustre: lustre-MDT0000-mdc-ffff9a8ec5709800: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [10310.645183] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [10310.689466] Lustre: Evicted from MGS (at 192.168.204.145@tcp) after server handle changed from 0x5e2a8a372338770f to 0x5e2a8a3723387b22 [10310.703592] Lustre: MGC192.168.204.145@tcp: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10315.789916] Lustre: lustre-MDT0000-mdc-ffff9a8ec5709800: Connection restored to 192.168.204.145@tcp (at 192.168.204.145@tcp) [10328.916161] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10331.067573] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10335.814711] Lustre: Unmounted lustre-client [10412.914273] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10418.709955] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10445.788662] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10447.070174] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [10449.042645] Lustre: Unmounted lustre-client [10476.546296] Key type lgssc unregistered [10476.886214] LNet: 225928:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10476.901324] LNetError: 225928:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10476.942136] LNet: Removed LNI 192.168.204.45@tcp [10477.956640] Key type .llcrypt unregistered [10477.960642] Key type ._llcrypt unregistered [10498.777595] Key type ._llcrypt registered [10498.781399] Key type .llcrypt registered [10500.190578] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 09:40:39 (1789134039) [10504.926558] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10504.961355] alg: No test for adler32 (adler32-zlib) [10506.129163] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [10506.408311] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [10508.135224] Key type lgssc registered [10509.268032] Lustre: Echo OBD driver; http://www.lustre.org/ [10565.034586] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10572.212743] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10602.554189] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10608.677963] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [10615.802823] Lustre: Unmounted lustre-client [10688.611766] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10693.565855] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10720.803220] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10721.341428] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [10730.748787] Lustre: Unmounted lustre-client [10809.857377] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10816.606886] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10844.043515] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10850.379255] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [10853.815025] Lustre: Unmounted lustre-client [10882.791159] Key type lgssc unregistered [10883.121246] LNet: 232984:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10883.140284] LNetError: 232984:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10883.161948] LNet: Removed LNI 192.168.204.45@tcp [10884.520725] Key type .llcrypt unregistered [10884.529077] Key type ._llcrypt unregistered [10904.361291] Key type ._llcrypt registered [10904.366289] Key type .llcrypt registered [10905.993829] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 09:47:25 (1789134445) [10909.601501] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10909.736733] alg: No test for adler32 (adler32-zlib) [10910.942715] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [10911.263330] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [10913.018136] Key type lgssc registered [10914.386142] Lustre: Echo OBD driver; http://www.lustre.org/ [10964.668163] Key type lgssc unregistered [10964.949203] LNet: 235322:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10964.955833] LNetError: 235322:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10964.988927] LNet: Removed LNI 192.168.204.45@tcp [10965.488730] Key type .llcrypt unregistered [10965.491729] Key type ._llcrypt unregistered [10994.377713] Key type ._llcrypt registered [10994.381363] Key type .llcrypt registered [10995.135392] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10995.172872] alg: No test for adler32 (adler32-zlib) [10996.342407] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [10996.602971] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [10998.271234] Key type lgssc registered [10999.542495] Lustre: Echo OBD driver; http://www.lustre.org/ [11089.489897] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11096.497758] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11123.558302] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11169.818601] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11171.673670] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 09:51:51 (1789134711) [11208.857331] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11215.070811] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11242.169116] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11267.380279] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11269.650050] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [11274.761210] Lustre: lustre-OST0001-osc-ffff9a8ec6da0800: Connection to lustre-OST0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [11283.945866] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11294.314569] Lustre: Unmounted lustre-client [11339.908356] Key type lgssc unregistered [11340.515477] LNet: 242442:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11340.538626] LNetError: 242442:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11340.619512] LNet: Removed LNI 192.168.204.45@tcp [11342.282787] Key type .llcrypt unregistered [11342.284900] Key type ._llcrypt unregistered [11389.303513] Key type ._llcrypt registered [11389.305925] Key type .llcrypt registered [11390.887803] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 09:55:30 (1789134930) [11411.319045] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11411.333558] alg: No test for adler32 (adler32-zlib) [11412.354937] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [11412.558113] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [11414.207672] Key type lgssc registered [11415.198613] Lustre: Echo OBD driver; http://www.lustre.org/ [11479.561518] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11487.304421] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11514.942568] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 09:57:34 (1789135054) [11556.215843] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11561.974845] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11586.698158] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11589.775286] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [11597.204744] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11605.639329] Lustre: Unmounted lustre-client [11719.873056] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11726.677624] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11785.582822] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11786.571942] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [11789.180932] Lustre: Unmounted lustre-client [11816.646428] Key type lgssc unregistered [11816.984822] LNet: 250160:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11816.992780] LNetError: 250160:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11817.009513] LNet: Removed LNI 192.168.204.45@tcp [11817.827873] Key type .llcrypt unregistered [11817.829953] Key type ._llcrypt unregistered [11847.614536] Key type ._llcrypt registered [11847.617511] Key type .llcrypt registered [11847.949666] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11847.965722] alg: No test for adler32 (adler32-zlib) [11848.941409] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [11849.142172] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [11850.799226] Key type lgssc registered [11851.882456] Lustre: Echo OBD driver; http://www.lustre.org/ [11953.831141] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11961.161764] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11987.379671] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12043.560939] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12046.016958] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 10:06:25 (1789135585) [12085.272233] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12092.123757] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12114.794922] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12129.401834] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [12133.973141] Lustre: Unmounted lustre-client [12163.308603] Key type lgssc unregistered [12163.656129] LNet: 256806:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12163.673475] LNetError: 256806:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12163.687771] LNet: Removed LNI 192.168.204.45@tcp [12164.598291] Key type .llcrypt unregistered [12164.601852] Key type ._llcrypt unregistered [12183.438587] Key type ._llcrypt registered [12183.442549] Key type .llcrypt registered [12184.974982] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12186.744707] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 10:08:46 (1789135726) [12196.318423] Key type .llcrypt unregistered [12196.322739] Key type ._llcrypt unregistered [12206.733608] Key type ._llcrypt registered [12206.735743] Key type .llcrypt registered [12207.302349] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12207.316232] alg: No test for adler32 (adler32-zlib) [12208.468325] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [12208.905742] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12210.575727] Key type lgssc registered [12211.911053] Lustre: Echo OBD driver; http://www.lustre.org/ [12270.122530] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12286.072758] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [12289.332929] Lustre: Unmounted lustre-client [12328.947490] Key type lgssc unregistered [12329.162732] LNet: 260268:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12329.166495] LNetError: 260268:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12329.188814] LNet: Removed LNI 192.168.204.45@tcp [12329.794133] Key type .llcrypt unregistered [12329.796107] Key type ._llcrypt unregistered [12348.042525] Key type ._llcrypt registered [12348.046883] Key type .llcrypt registered [12349.444833] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 10:11:29 (1789135889) [12352.383603] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12352.528237] alg: No test for adler32 (adler32-zlib) [12353.699125] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [12354.041601] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12355.759204] Key type lgssc registered [12357.260683] Lustre: Echo OBD driver; http://www.lustre.org/ [12444.664347] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12480.452684] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12486.506508] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12489.448925] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [12492.064540] Lustre: Unmounted lustre-client [12513.889966] Key type lgssc unregistered [12514.235788] LNet: 263814:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12514.241272] LNetError: 263814:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12514.271514] LNet: Removed LNI 192.168.204.45@tcp [12515.031352] Key type .llcrypt unregistered [12515.033793] Key type ._llcrypt unregistered [12533.381996] Key type ._llcrypt registered [12533.383911] Key type .llcrypt registered [12534.993755] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 10:14:34 (1789136074) [12537.038181] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12537.062386] alg: No test for adler32 (adler32-zlib) [12538.108141] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [12538.391739] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12540.143216] Key type lgssc registered [12541.394452] Lustre: Echo OBD driver; http://www.lustre.org/ [12594.987907] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12600.488940] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12620.607221] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12623.355935] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [12628.475556] Lustre: lustre-MDT0000-mdc-ffff9a8ec767a800: Connection to lustre-MDT0000 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [12634.630701] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12634.656520] LustreError: 266967:0:(file.c:6184:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12635.159914] LustreError: 266987:0:(file.c:6184:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12635.166873] LustreError: 266987:0:(file.c:6184:ll_inode_revalidate_fini()) Skipped 5 previous similar messages [12635.212599] LustreError: MGC192.168.204.145@tcp: Connection to MGS (at 192.168.204.145@tcp) was lost; in progress operations using this service will fail [12635.263428] Lustre: Unmounted lustre-client [12656.742955] Key type lgssc unregistered [12656.995268] LNet: 267385:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12657.010892] LNetError: 267385:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12657.035872] LNet: Removed LNI 192.168.204.45@tcp [12657.846121] Key type .llcrypt unregistered [12657.848438] Key type ._llcrypt unregistered [12675.707950] Key type ._llcrypt registered [12675.721479] Key type .llcrypt registered [12677.365577] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 10:16:56 (1789136216) [12680.229079] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12680.243886] alg: No test for adler32 (adler32-zlib) [12681.492969] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [12681.689667] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12683.439265] Key type lgssc registered [12685.073039] Lustre: Echo OBD driver; http://www.lustre.org/ [12740.092456] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12746.584778] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12769.014546] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12770.710752] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [12781.030384] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12783.551413] Lustre: Unmounted lustre-client [12804.570587] Key type lgssc unregistered [12804.861799] LNet: 270969:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12804.870721] LNetError: 270969:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12804.895568] LNet: Removed LNI 192.168.204.45@tcp [12805.735847] Key type .llcrypt unregistered [12805.738589] Key type ._llcrypt unregistered [12823.560159] Key type ._llcrypt registered [12823.562240] Key type .llcrypt registered [12824.887565] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 10:19:24 (1789136364) [12843.999961] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12844.038888] alg: No test for adler32 (adler32-zlib) [12845.265289] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [12845.532712] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [12847.191447] Key type lgssc registered [12848.785580] Lustre: Echo OBD driver; http://www.lustre.org/ [12961.378965] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12963.050905] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [13005.799493] Lustre: lustre-MDT0001-mdc-ffff9a8ed11f2800: Connection to lustre-MDT0001 (at 192.168.204.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [13016.953479] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13027.312900] Lustre: Unmounted lustre-client [13063.162672] Key type lgssc unregistered [13063.388348] LNet: 276762:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13063.408360] LNetError: 276762:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13063.431335] LNet: Removed LNI 192.168.204.45@tcp [13064.079120] Key type .llcrypt unregistered [13064.080822] Key type ._llcrypt unregistered [13079.130961] Key type ._llcrypt registered [13079.134654] Key type .llcrypt registered [13080.403598] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 10:23:40 (1789136620) [13081.893470] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13083.359571] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 10:23:43 (1789136623) [13084.508248] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13086.068160] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 10:23:46 (1789136626) [13087.642206] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13089.329962] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 10:23:49 (1789136629) [13091.134915] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13092.951870] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 10:23:52 (1789136632) [13094.814355] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13097.039990] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 10:23:56 (1789136636) [13107.613480] Key type .llcrypt unregistered [13107.621315] Key type ._llcrypt unregistered [13116.426170] Key type ._llcrypt registered [13116.427968] Key type .llcrypt registered [13116.636144] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13116.646387] alg: No test for adler32 (adler32-zlib) [13117.739899] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [13117.982153] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [13119.663197] Key type lgssc registered [13120.722417] Lustre: Echo OBD driver; http://www.lustre.org/ [13192.817244] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13198.025410] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13219.995622] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13221.766051] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [13224.711815] Lustre: Unmounted lustre-client [13263.883969] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 10:26:43 (1789136803) [13298.320517] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13304.226772] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13340.653765] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13346.864151] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [13349.363953] Lustre: Unmounted lustre-client [13393.504036] LNet: 1 local NIs in recovery (showing 1): 192.168.204.45@tcp [13402.656859] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 10:29:02 (1789136942) [14055.774443] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14062.002965] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14099.499243] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14204.862552] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 10:42:24 (1789137744) [14216.551949] Key type lgssc unregistered [14216.754463] LNet: 290297:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14216.766339] LNetError: 290297:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14216.787320] LNet: Removed LNI 192.168.204.45@tcp [14217.348910] Key type .llcrypt unregistered [14217.353933] Key type ._llcrypt unregistered [14349.338860] Key type ._llcrypt registered [14349.348756] Key type .llcrypt registered [14350.119062] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14350.138365] alg: No test for adler32 (adler32-zlib) [14351.411514] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [14351.749484] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [14353.559401] Key type lgssc registered [14355.308791] Lustre: Echo OBD driver; http://www.lustre.org/ [14447.234230] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14453.589890] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14479.660403] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14522.455137] Key type lgssc unregistered [14522.757235] LNet: 293998:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14522.763979] LNetError: 293998:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14522.778167] LNet: Removed LNI 192.168.204.45@tcp [14523.481593] Key type .llcrypt unregistered [14523.484406] Key type ._llcrypt unregistered [14561.120946] Key type ._llcrypt registered [14561.123832] Key type .llcrypt registered [14562.632441] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 10:48:22 (1789138102) [14587.828627] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14587.843020] alg: No test for adler32 (adler32-zlib) [14589.131360] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [14589.493820] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [14591.247229] Key type lgssc registered [14592.633614] Lustre: Echo OBD driver; http://www.lustre.org/ [14651.262709] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 10:49:50 (1789138190) [14664.793229] Key type lgssc unregistered [14665.046600] LNet: 297558:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14665.056980] LNetError: 297558:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14665.074826] LNet: Removed LNI 192.168.204.45@tcp [14665.941684] Key type .llcrypt unregistered [14665.944480] Key type ._llcrypt unregistered [14679.531711] Key type ._llcrypt registered [14679.538597] Key type .llcrypt registered [14680.237114] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14680.250822] alg: No test for adler32 (adler32-zlib) [14681.394392] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [14681.696293] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [14683.471885] Key type lgssc registered [14684.853418] Lustre: Echo OBD driver; http://www.lustre.org/ [14745.934970] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14752.704936] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14777.756179] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15108.785444] LNet: Added LNI 192.168.204.45@tcp50 [8/256/0/180] [15111.635587] LNet: Removed LNI 192.168.204.45@tcp [15113.847646] Lustre: 301970:0:(ldlm_lib.c:599:client_obd_setup()) lustre-MDT0000-mdc-ffff9a8ec7fff800: config has no valid NIDs, force dynamic NIDs [15115.089777] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [15115.290669] Lustre: Unmounted lustre-client [15118.586297] Key type lgssc unregistered [15118.976757] LNet: 302234:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15118.983186] LNetError: 302234:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15119.004596] LNet: Removed LNI 192.168.204.45@tcp50 [15119.820201] Key type .llcrypt unregistered [15119.824815] Key type ._llcrypt unregistered [15138.461351] Key type ._llcrypt registered [15138.464975] Key type .llcrypt registered [15138.989821] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15139.006348] alg: No test for adler32 (adler32-zlib) [15140.109953] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [15140.358987] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [15142.071210] Key type lgssc registered [15143.399374] Lustre: Echo OBD driver; http://www.lustre.org/ [15205.585325] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15211.617365] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15219.422273] LNet: Added LNI 192.168.204.45@tcp50 [8/256/0/180] [15220.264964] LNet: Removed LNI 192.168.204.45@tcp [15221.487879] Lustre: 304924:0:(ldlm_lib.c:599:client_obd_setup()) lustre-MDT0000-mdc-ffff9a8ec767f800: config has no valid NIDs, force dynamic NIDs [15222.699564] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [15223.243476] Lustre: Unmounted lustre-client [15267.177984] Key type lgssc unregistered [15267.603865] LNet: 305800:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15267.614204] LNetError: 305800:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15267.634364] LNet: Removed LNI 192.168.204.45@tcp50 [15268.255920] Key type .llcrypt unregistered [15268.258834] Key type ._llcrypt unregistered [15281.297759] Key type ._llcrypt registered [15281.299948] Key type .llcrypt registered [15282.784071] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 11:00:22 (1789138822) [15302.631607] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15302.812534] alg: No test for adler32 (adler32-zlib) [15304.068075] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [15304.323800] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [15305.991623] Key type lgssc registered [15307.211611] Lustre: Echo OBD driver; http://www.lustre.org/ [15397.680224] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15404.519870] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15432.234351] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15473.415808] Key type lgssc unregistered [15473.798347] LNet: 310567:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15473.804089] LNetError: 310567:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15473.819859] LNet: Removed LNI 192.168.204.45@tcp [15474.764123] Key type .llcrypt unregistered [15474.769826] Key type ._llcrypt unregistered [15487.263982] Key type ._llcrypt registered [15487.266185] Key type .llcrypt registered [15488.518321] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 11:03:48 (1789139028) [15490.807322] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15490.872813] alg: No test for adler32 (adler32-zlib) [15491.968911] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [15492.236591] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [15493.896352] Key type lgssc registered [15495.072184] Lustre: Echo OBD driver; http://www.lustre.org/ [15545.601342] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15550.741959] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15571.860144] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15573.597107] Lustre: Mounted lustre-client - version 2.17.57_138_g7946b16 [15631.190159] Lustre: Mounted fs15246-client - version 2.17.57_138_g7946b16 [15646.443105] Lustre: Unmounted fs15246-client [15668.861741] Lustre: Unmounted lustre-client [15706.684350] Key type lgssc unregistered [15707.021652] LNet: 315424:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15707.030872] LNetError: 315424:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15707.055311] LNet: Removed LNI 192.168.204.45@tcp [15707.850842] Key type .llcrypt unregistered [15707.859124] Key type ._llcrypt unregistered [15720.636747] Key type ._llcrypt registered [15720.640147] Key type .llcrypt registered [15722.089677] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 11:07:41 (1789139261) [15723.569935] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15723.593390] alg: No test for adler32 (adler32-zlib) [15724.682495] Lustre: Lustre: Build Version: 2.17.57_138_g7946b16 [15724.964709] LNet: Added LNI 192.168.204.45@tcp [8/256/0/180] [15726.639138] Key type lgssc registered [15727.967703] Lustre: Echo OBD driver; http://www.lustre.org/ [15860.028474] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15865.522773] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15890.099904] Lustre: DEBUG MARKER: oleg445-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15996.499401] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15695 sec ========= 11:12:15 (1789139535) [15998.376967] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 11:12:17 (1789139537) === [16002.684656] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 11:12:21 (1789139541) === [16036.340933] Key type lgssc unregistered [16036.613444] LNet: 324697:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16036.623430] LNetError: 324697:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16036.646637] LNet: Removed LNI 192.168.204.45@tcp [16037.281483] Key type .llcrypt unregistered [16037.287459] Key type ._llcrypt unregistered