[ 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 417478569 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001012] APIC: Switch to symmetric I/O mode setup [ 0.003311] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005015] kvm-guest: setup PV IPIs [ 0.008689] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009022] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010014] pid_max: default: 32768 minimum: 301 [ 0.011133] LSM: Security Framework initializing [ 0.012071] Yama: becoming mindful. [ 0.013042] SELinux: Initializing. [ 0.014088] *** VALIDATE selinux *** [ 0.022602] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027703] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028172] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029128] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030120] *** VALIDATE tmpfs *** [ 0.031418] *** VALIDATE proc *** [ 0.032240] *** VALIDATE cgroup *** [ 0.033009] *** VALIDATE cgroup2 *** [ 0.034291] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036072] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038034] Spectre V2 : User space: Vulnerable [ 0.039010] Speculative Store Bypass: Vulnerable [ 0.042554] debug: unmapping init [mem 0xffffffff95459000-0xffffffff95460fff] [ 0.043583] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.045367] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.046031] ... version: 2 [ 0.047014] ... bit width: 48 [ 0.048014] ... generic registers: 4 [ 0.049016] ... value mask: 0000ffffffffffff [ 0.050016] ... max period: 00007fffffffffff [ 0.051015] ... fixed-purpose events: 3 [ 0.052015] ... event mask: 000000070000000f [ 0.053346] rcu: Hierarchical SRCU implementation. [ 0.055587] smp: Bringing up secondary CPUs ... [ 0.056638] x86: Booting SMP configuration: [ 0.057027] .... node #0, CPUs: #1 #2 #3 [ 0.060456] smp: Brought up 1 node, 4 CPUs [ 0.062014] smpboot: Max logical packages: 1 [ 0.063020] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.136120] node 0 deferred pages initialised in 70ms [ 0.139209] devtmpfs: initialized [ 0.141392] x86/mm: Memory block size: 128MB [ 0.145316] gcov: version magic: 0x41383552 [ 0.149082] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.150088] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.151298] pinctrl core: initialized pinctrl subsystem [ 0.152263] [ 0.152723] ************************************************************* [ 0.154017] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.155014] ** ** [ 0.158016] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.160013] ** ** [ 0.163016] ** This means that this kernel is built to expose internal ** [ 0.165012] ** IOMMU data structures, which may compromise security on ** [ 0.166011] ** your system. ** [ 0.167010] ** ** [ 0.169010] ** If you see this message and you are not debugging the ** [ 0.171012] ** kernel, report this immediately to your vendor! ** [ 0.172011] ** ** [ 0.174014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.176016] ************************************************************* [ 0.178640] NET: Registered protocol family 16 [ 0.180721] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.183086] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.186068] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.190187] cpuidle: using governor menu [ 0.192836] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.195719] PCI: Using configuration type 1 for base access [ 0.198164] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.207249] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.210037] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.212136] cryptd: max_cpu_qlen set to 1000 [ 0.215279] ACPI: Added _OSI(Module Device) [ 0.217031] ACPI: Added _OSI(Processor Device) [ 0.219021] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.221043] ACPI: Added _OSI(Processor Aggregator Device) [ 0.226246] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.233339] ACPI: Interpreter enabled [ 0.234094] ACPI: PM: (supports S0 S3 S4 S5) [ 0.236023] ACPI: Using IOAPIC for interrupt routing [ 0.238154] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.241476] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.251951] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.255071] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.257029] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.261118] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.266552] acpiphp: Slot [2] registered [ 0.268267] acpiphp: Slot [5] registered [ 0.269256] acpiphp: Slot [6] registered [ 0.271162] acpiphp: Slot [3] registered [ 0.273109] acpiphp: Slot [4] registered [ 0.274118] acpiphp: Slot [7] registered [ 0.276152] acpiphp: Slot [8] registered [ 0.277099] acpiphp: Slot [9] registered [ 0.278066] acpiphp: Slot [10] registered [ 0.279119] acpiphp: Slot [11] registered [ 0.281129] acpiphp: Slot [12] registered [ 0.283124] acpiphp: Slot [13] registered [ 0.284127] acpiphp: Slot [14] registered [ 0.285188] acpiphp: Slot [15] registered [ 0.287118] acpiphp: Slot [16] registered [ 0.289129] acpiphp: Slot [17] registered [ 0.290120] acpiphp: Slot [18] registered [ 0.292119] acpiphp: Slot [19] registered [ 0.293117] acpiphp: Slot [20] registered [ 0.295112] acpiphp: Slot [21] registered [ 0.296074] acpiphp: Slot [22] registered [ 0.297139] acpiphp: Slot [23] registered [ 0.299101] acpiphp: Slot [24] registered [ 0.300069] acpiphp: Slot [25] registered [ 0.301082] acpiphp: Slot [26] registered [ 0.302099] acpiphp: Slot [27] registered [ 0.303118] acpiphp: Slot [28] registered [ 0.304082] acpiphp: Slot [29] registered [ 0.304953] acpiphp: Slot [30] registered [ 0.306077] acpiphp: Slot [31] registered [ 0.307086] PCI host bridge to bus 0000:00 [ 0.308019] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.310037] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.312042] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.315041] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.318040] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.320032] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.321232] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.325150] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.328490] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.337024] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.342063] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.345031] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.347028] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.350032] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.354158] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.355692] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.358048] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.360769] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.363992] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.373020] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.378016] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.382377] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.392027] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.400026] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.424024] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.433071] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.442065] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.445857] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.456016] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.465114] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.468333] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.469383] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.470425] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.473436] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.478169] iommu: Default domain type: Passthrough [ 0.479481] SCSI subsystem initialized [ 0.481127] ACPI: bus type USB registered [ 0.482099] usbcore: registered new interface driver usbfs [ 0.484090] usbcore: registered new interface driver hub [ 0.486094] usbcore: registered new device driver usb [ 0.488187] pps_core: LinuxPPS API ver. 1 registered [ 0.489008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.491058] PTP clock support registered [ 0.493090] EDAC MC: Ver: 3.0.0 [ 0.494412] PCI: Using ACPI for IRQ routing [ 0.496890] NetLabel: Initializing [ 0.498019] NetLabel: domain hash size = 128 [ 0.500019] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.502116] NetLabel: unlabeled traffic allowed by default [ 0.504192] vgaarb: loaded [ 0.506255] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.507011] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.516000] clocksource: Switched to clocksource kvm-clock [ 0.622222] VFS: Disk quotas dquot_6.6.0 [ 0.623794] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.626653] *** VALIDATE ramfs *** [ 0.627901] *** VALIDATE hugetlbfs *** [ 0.629738] pnp: PnP ACPI init [ 0.633201] pnp: PnP ACPI: found 6 devices [ 0.658147] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.661667] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.663900] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.665805] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.668330] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.671137] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.674200] NET: Registered protocol family 2 [ 0.676779] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.682147] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.685029] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.689727] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.692816] TCP: Hash tables configured (established 65536 bind 65536) [ 0.695494] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.699067] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.701617] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.704386] NET: Registered protocol family 1 [ 0.706923] RPC: Registered named UNIX socket transport module. [ 0.709258] RPC: Registered udp transport module. [ 0.711187] RPC: Registered tcp transport module. [ 0.712870] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.714779] NET: Registered protocol family 44 [ 0.716042] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.718336] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.720647] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.723200] PCI: CLS 0 bytes, default 64 [ 0.724947] Unpacking initramfs... [ 2.130521] debug: unmapping init [mem 0xffff993d7cc64000-0xffff993d7ffcffff] [ 2.134647] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.136938] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.140084] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.665905] Initialise system trusted keyrings [ 2.667759] Key type blacklist registered [ 2.669717] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.680244] zbud: loaded [ 2.683982] *** VALIDATE nfs *** [ 2.685391] *** VALIDATE nfs4 *** [ 2.686700] pstore: using deflate compression [ 2.690037] Platform Keyring initialized [ 2.809631] NET: Registered protocol family 38 [ 2.811853] Key type asymmetric registered [ 2.814096] Asymmetric key parser 'x509' registered [ 2.816213] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.819913] io scheduler mq-deadline registered [ 2.821882] io scheduler kyber registered [ 2.823661] io scheduler bfq registered [ 2.826081] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.829178] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.831995] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.834724] ACPI: Power Button [PWRF] [ 2.840349] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.846647] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.855992] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.885064] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.914043] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.918949] Non-volatile memory driver v1.3 [ 2.920552] Linux agpgart interface v0.103 [ 2.950621] virtio_blk virtio1: [vda] 146728 512-byte logical blocks (75.1 MB/71.6 MiB) [ 2.952852] vda: detected capacity change from 0 to 75124736 [ 2.969365] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.972573] vdb: detected capacity change from 0 to 1073741824 [ 2.981729] libphy: Fixed MDIO Bus: probed [ 2.989321] usbcore: registered new interface driver usbserial_generic [ 2.991907] usbserial: USB Serial support registered for generic [ 2.995114] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.000512] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.002676] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.005810] mousedev: PS/2 mouse device common for all mice [ 3.009489] rtc_cmos 00:05: RTC can wake from S4 [ 3.012420] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.013435] rtc_cmos 00:05: registered as rtc0 [ 3.018118] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.020210] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.021754] intel_pstate: CPU model not supported [ 3.026659] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.031341] hid: raw HID events driver (C) Jiri Kosina [ 3.033556] usbcore: registered new interface driver usbhid [ 3.035778] usbhid: USB HID core driver [ 3.037433] drop_monitor: Initializing network drop monitor service [ 3.039932] Initializing XFRM netlink socket [ 3.042112] NET: Registered protocol family 10 [ 3.045447] Segment Routing with IPv6 [ 3.047037] NET: Registered protocol family 17 [ 3.049054] mpls_gso: MPLS GSO support [ 3.055210] RAS: Correctable Errors collector initialized. [ 3.057280] AVX version of gcm_enc/dec engaged. [ 3.058911] AES CTR mode by8 optimization enabled [ 3.136942] sched_clock: Marking stable (3136912460, 0)->(3994420851, -857508391) [ 3.140255] registered taskstats version 1 [ 3.142218] Loading compiled-in X.509 certificates [ 3.144821] zswap: loaded using pool lzo/zbud [ 3.170088] Key type big_key registered [ 3.183515] Key type encrypted registered [ 3.185381] ima: No TPM chip found, activating TPM-bypass! [ 3.187430] ima: Allocated hash algorithm: sha1 [ 3.189208] ima: No architecture policies found [ 3.190558] evm: Initialising EVM extended attributes: [ 3.192413] evm: security.selinux [ 3.193615] evm: security.ima [ 3.194670] evm: security.capability [ 3.196029] evm: HMAC attrs: 0x1 [ 3.198414] rtc_cmos 00:05: setting system clock to 2026-09-08 03:04:49 UTC (1788836689) [ 3.204848] debug: unmapping init [mem 0xffffffff96403000-0xffffffff965fffff] [ 3.207910] debug: unmapping init [mem 0xffffffff95182000-0xffffffff95458fff] [ 3.217174] Write protecting the kernel read-only data: 28672k [ 3.221030] debug: unmapping init [mem 0xffffffff93803000-0xffffffff939fffff] [ 3.224043] debug: unmapping init [mem 0xffffffff94114000-0xffffffff941fffff] [ 3.259225] 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.266731] systemd[1]: Detected virtualization kvm. [ 3.268966] systemd[1]: Detected architecture x86-64. [ 3.270567] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.295721] systemd[1]: No hostname configured. [ 3.297084] systemd[1]: Set hostname to . [ 3.298762] random: systemd: uninitialized urandom read (16 bytes read) [ 3.300570] systemd[1]: Initializing machine ID from random generator. [ 3.348632] random: ln: uninitialized urandom read (6 bytes read) [ 3.424136] random: systemd: uninitialized urandom read (16 bytes read) [ 3.425820] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.428860] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 3.432230] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Local File Systems. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Swap. Starting Create Volatile Files and Directories... Starting Setup Virtual Console... Starting Apply Kernel Variables... [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Local Encrypted Volumes. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ 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.151935] device-mapper: uevent: version 1.0.3 [ 4.155050] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon.[ 4.983206] random: fast init done [ 5.078956] virtio_net virtio0 ens2: renamed from eth0 [ 5.242044] scsi host0: ata_piix [ 5.259329] scsi host1: ata_piix [ 5.261193] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.263872] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.023754] dracut-initqueue[579]: RTNETLINK answers: File exists [ 9.700712] random: crng init done [ 9.702364] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.316900] 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. Stopping Hardware RNG Entropy Gatherer Daemon... [ 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. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ 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 Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.574207] printk: systemd: 25 output lines suppressed due to ratelimiting [ 11.848244] SELinux: Disabled at runtime. [ 11.906812] 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.916132] systemd[1]: Detected virtualization kvm. [ 11.918240] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.456186] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.460543] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.467145] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.472070] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.475689] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.483939] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.487885] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting Kernel Debug File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Starting Remount Root and Kernel File Systems... Mounting Huge Pages File System... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Created slice system-serial\x2dgetty.slice. Mounting POSIX Message Queue File System... [ OK ] Created slice system-getty.slice. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Listening on udev Control Socket. [ OK ] Reached target rpc_pipefs.target. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice system-sshd\x2dkeygen.slice. Starting Apply Kernel Variables... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Stopped target Initrd Root 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. [ OK ] Listening on Process Core Dump Socket. Activating swap /dev/disk/by-label/SWAP... [ OK ] Started Journal Service. [ 12.714194] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 13.011458] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.364988] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.391238] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.544869] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.555514] EDAC sbridge: Ver: 1.1.2 [ 14.751379] Key type dns_resolver registered [ 15.046131] NFS: Registering the id_resolver key type [ 15.047620] Key type id_resolver registered [ 15.048830] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting 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 Cleanup of Temporary Directories. [ 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. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Login Service. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Authorization Manager. [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg213-client login: [ 76.014079] libcfs: loading out-of-tree module taints kernel. [ 76.131507] Key type ._llcrypt registered [ 76.135658] Key type .llcrypt registered [ 77.187302] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 77.209819] alg: No test for adler32 (adler32-zlib) [ 78.982287] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 80.894557] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 82.735260] Key type lgssc registered [ 85.197648] Lustre: Echo OBD driver; http://www.lustre.org/ [ 87.766206] hrtimer: interrupt took 6140427 ns [ 279.775460] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 284.500951] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 297.161936] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing check_logdir /tmp/testlogs/ [ 303.559052] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing yml_node [ 305.631343] Lustre: lustre-OST0000-osc-ffff993dc8b7e000: disconnect after 23s idle [ 309.514345] Lustre: DEBUG MARKER: Client: 2.17.57.113 [ 313.116409] Lustre: DEBUG MARKER: MDS: 2.17.57.113 [ 315.945326] Lustre: DEBUG MARKER: OSS: 2.17.57.113 [ 317.773154] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon Sep 7 23:10:02 EDT 2026 [ 338.050200] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 340.001729] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 343.552712] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 353.891268] Lustre: Unmounted lustre-client [ 470.794088] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 476.568471] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 501.828174] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 541.622329] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 23:13:46 (1788837226) [ 544.291888] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 545.982276] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 23:13:50 (1788837230) [ 580.715522] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 586.293956] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 608.991399] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 609.693992] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 617.703070] Lustre: Unmounted lustre-client [ 645.210218] Key type lgssc unregistered [ 645.521675] LNet: 15026:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 645.531168] LNetError: 15026:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 645.555282] LNet: Removed LNI 192.168.202.13@tcp [ 646.314162] Key type .llcrypt unregistered [ 646.315910] Key type ._llcrypt unregistered [ 661.293301] Key type ._llcrypt registered [ 661.296557] Key type .llcrypt registered [ 662.473821] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 23:15:47 (1788837347) [ 664.308792] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 664.341020] alg: No test for adler32 (adler32-zlib) [ 665.339250] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 665.551182] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 667.215226] Key type lgssc registered [ 668.586221] Lustre: Echo OBD driver; http://www.lustre.org/ [ 744.701095] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 828.610703] Lustre: Unmounted lustre-client [ 860.021614] Key type lgssc unregistered [ 860.359916] LNet: 18850:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 860.374646] LNetError: 18850:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 860.395264] LNet: Removed LNI 192.168.202.13@tcp [ 861.382853] Key type .llcrypt unregistered [ 861.385805] Key type ._llcrypt unregistered [ 871.544411] Key type ._llcrypt registered [ 871.547571] Key type .llcrypt registered [ 872.968573] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 23:19:17 (1788837557) [ 875.346015] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 875.467400] alg: No test for adler32 (adler32-zlib) [ 876.548337] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 876.806669] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 878.479373] Key type lgssc registered [ 879.711792] Lustre: Echo OBD driver; http://www.lustre.org/ [ 933.672527] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 940.407754] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 961.924436] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 964.659749] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 974.241081] Lustre: Unmounted lustre-client [ 1010.381238] Key type lgssc unregistered [ 1010.596982] LNet: 22453:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1010.604228] LNetError: 22453:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1010.620143] LNet: Removed LNI 192.168.202.13@tcp [ 1011.277115] Key type .llcrypt unregistered [ 1011.279578] Key type ._llcrypt unregistered [ 1021.083270] Key type ._llcrypt registered [ 1021.085487] Key type .llcrypt registered [ 1022.348108] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 23:21:47 (1788837707) [ 1025.086575] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1025.114048] alg: No test for adler32 (adler32-zlib) [ 1026.188621] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 1026.487952] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 1028.143337] Key type lgssc registered [ 1029.254729] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1083.093898] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1088.621336] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1108.633896] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1111.587416] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 1120.602206] Lustre: Unmounted lustre-client [ 1149.880634] Key type lgssc unregistered [ 1150.280446] LNet: 25639:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1150.293837] LNetError: 25639:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1150.320765] LNet: Removed LNI 192.168.202.13@tcp [ 1151.386497] Key type .llcrypt unregistered [ 1151.388542] Key type ._llcrypt unregistered [ 1169.716474] Key type ._llcrypt registered [ 1169.722030] Key type .llcrypt registered [ 1171.372906] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 23:24:15 (1788837855) [ 1174.266375] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1174.318510] alg: No test for adler32 (adler32-zlib) [ 1175.432814] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 1175.722060] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 1177.431176] Key type lgssc registered [ 1178.354351] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1231.181768] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1237.360225] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1260.563754] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1263.458960] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 1268.720597] Lustre: lustre-MDT0000-mdc-ffff993dc31cf000: Connection to lustre-MDT0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1289.195665] Lustre: lustre-MDT0001-mdc-ffff993dc31cf000: Connection to lustre-MDT0001 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1295.056422] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1300.447277] Lustre: 26597:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788837970/real 1788837970] req@0000000093b22109 x1875732449991168/t0(0) o400->MGC192.168.202.113@tcp@192.168.202.113@tcp:26/25 lens 224/224 e 0 to 1 dl 1788837986 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1300.486362] LustreError: MGC192.168.202.113@tcp: Connection to MGS (at 192.168.202.113@tcp) was lost; in progress operations using this service will fail [ 1305.429609] Lustre: Unmounted lustre-client [ 1321.433666] Key type lgssc unregistered [ 1321.840106] LNet: 29292:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1321.847707] LNetError: 29292:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1321.878635] LNet: Removed LNI 192.168.202.13@tcp [ 1322.597506] Key type .llcrypt unregistered [ 1322.602663] Key type ._llcrypt unregistered [ 1340.042466] Key type ._llcrypt registered [ 1340.045291] Key type .llcrypt registered [ 1341.618672] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 23:27:06 (1788838026) [ 1344.426211] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1344.459402] alg: No test for adler32 (adler32-zlib) [ 1345.643719] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 1345.982386] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 1347.664832] Key type lgssc registered [ 1349.259429] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1404.530211] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1411.651708] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1433.403287] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1434.986268] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 1445.385119] Lustre: lustre-OST0000-osc-ffff993dd8a71000: Connection to lustre-OST0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1450.834982] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1461.246624] Lustre: Unmounted lustre-client [ 1489.431716] Key type lgssc unregistered [ 1489.728049] LNet: 32907:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1489.735296] LNetError: 32907:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1489.780307] LNet: Removed LNI 192.168.202.13@tcp [ 1490.688993] Key type .llcrypt unregistered [ 1490.699599] Key type ._llcrypt unregistered [ 1508.257376] Key type ._llcrypt registered [ 1508.261178] Key type .llcrypt registered [ 1509.920216] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 23:29:54 (1788838194) [ 1512.602073] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1512.677790] alg: No test for adler32 (adler32-zlib) [ 1513.701893] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 1513.911729] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 1515.559193] Key type lgssc registered [ 1516.819055] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1570.085791] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1576.265770] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1599.515623] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1602.709185] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 1607.604714] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1611.806780] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1623.345598] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-0723h31m48s [ 1625.432919] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1628.145914] Lustre: lustre-MDT0000-mdc-ffff993dd8ac6800: Connection to lustre-MDT0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1636.259726] LustreError: 36697:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff993dd8ac6800: can't stat MDS #0: rc = -19 [ 1638.030449] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1645.558186] LustreError: MGC192.168.202.113@tcp: Connection to MGS (at 192.168.202.113@tcp) was lost; in progress operations using this service will fail [ 1645.581954] Lustre: Evicted from MGS (at 192.168.202.113@tcp) after server handle changed from 0x69e07f0901c1cdab to 0x69e07f0901c1cfcd [ 1645.593541] Lustre: MGC192.168.202.113@tcp: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [ 1646.634696] LustreError: lustre-MDT0000-mdc-ffff993dd8ac6800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1646.654292] Lustre: lustre-MDT0000-mdc-ffff993dd8ac6800: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [ 1654.966856] Lustre: DEBUG MARKER: Wait for df (36697) ... [ 1657.041985] Lustre: DEBUG MARKER: done [ 1659.821112] Lustre: Unmounted lustre-client [ 1698.493560] Key type lgssc unregistered [ 1698.709712] LNet: 37715:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1698.724437] LNetError: 37715:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1698.739265] LNet: Removed LNI 192.168.202.13@tcp [ 1699.736551] Key type .llcrypt unregistered [ 1699.738765] Key type ._llcrypt unregistered [ 1736.723047] Key type ._llcrypt registered [ 1736.725693] Key type .llcrypt registered [ 1738.205746] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 23:33:42 (1788838422) [ 1741.422201] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1741.505165] alg: No test for adler32 (adler32-zlib) [ 1742.637433] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 1743.177283] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 1744.871173] Key type lgssc registered [ 1746.618621] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1812.885328] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1819.825514] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1844.020373] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1846.775119] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 1851.906409] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-0723h35m36s [ 1853.348562] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1861.215397] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1864.480448] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1885.151359] Lustre: 41868:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788838551/real 1788838551] req@00000000b05ec4a3 x1875733044534016/t0(0) o101->lustre-MDT0000-mdc-ffff993de029f000@192.168.202.113@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788838571 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1885.211204] Lustre: lustre-MDT0000-mdc-ffff993de029f000: Connection to lustre-MDT0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1885.264920] Lustre: lustre-MDT0000-mdc-ffff993de029f000: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [ 1906.822274] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1910.396591] Lustre: DEBUG MARKER: done [ 1915.130513] Lustre: Unmounted lustre-client [ 1947.204848] Key type lgssc unregistered [ 1947.637750] LNet: 42744:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1947.657303] LNetError: 42744:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1947.703264] LNet: Removed LNI 192.168.202.13@tcp [ 1948.838539] Key type .llcrypt unregistered [ 1948.840144] Key type ._llcrypt unregistered [ 1984.159895] Key type ._llcrypt registered [ 1984.162910] Key type .llcrypt registered [ 1985.394608] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 23:37:50 (1788838670) [ 1986.977648] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1988.928809] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 23:37:53 (1788838673) [ 1992.583790] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1992.606843] alg: No test for adler32 (adler32-zlib) [ 1993.637702] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 1993.772894] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 1995.431975] Key type lgssc registered [ 1996.646455] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2028.776410] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 23:38:33 (1788838713) [ 2072.901156] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2081.579437] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2105.743236] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2107.782258] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 2111.391424] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2115.313144] Lustre: Unmounted lustre-client [ 2134.176878] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2184.077684] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2189.717597] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2190.491434] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 2194.394801] Lustre: Unmounted lustre-client [ 2254.881098] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2261.436551] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2262.418065] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 2265.992365] Lustre: Unmounted lustre-client [ 2283.544545] Lustre: DEBUG MARKER: files compared the same [ 2305.324622] Key type lgssc unregistered [ 2305.650677] LNet: 50374:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2305.663449] LNetError: 50374:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2305.694282] LNet: Removed LNI 192.168.202.13@tcp [ 2306.491862] Key type .llcrypt unregistered [ 2306.495135] Key type ._llcrypt unregistered [ 2321.192410] Key type ._llcrypt registered [ 2321.194457] Key type .llcrypt registered [ 2322.312743] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 23:43:27 (1788839007) [ 2324.186053] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2324.272937] alg: No test for adler32 (adler32-zlib) [ 2325.248938] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 2325.455318] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 2327.111643] Key type lgssc registered [ 2328.311157] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2374.700702] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2380.522605] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2403.155613] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2405.706736] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 2409.057881] Lustre: Unmounted lustre-client [ 2434.986240] Key type lgssc unregistered [ 2435.227774] LNet: 53951:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2435.236620] LNetError: 53951:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2435.253354] LNet: Removed LNI 192.168.202.13@tcp [ 2435.975441] Key type .llcrypt unregistered [ 2435.977127] Key type ._llcrypt unregistered [ 2449.787990] Key type ._llcrypt registered [ 2449.789947] Key type .llcrypt registered [ 2451.021692] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 23:45:35 (1788839135) [ 2453.520138] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2453.538090] alg: No test for adler32 (adler32-zlib) [ 2454.671986] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 2455.009142] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 2456.767169] Key type lgssc registered [ 2458.100337] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2547.513780] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2589.703221] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2597.160971] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2636.231082] Key type lgssc unregistered [ 2636.582899] LNet: 57440:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2636.591813] LNetError: 57440:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2636.619757] LNet: Removed LNI 192.168.202.13@tcp [ 2637.519855] Key type .llcrypt unregistered [ 2637.522155] Key type ._llcrypt unregistered [ 2658.349359] Key type ._llcrypt registered [ 2658.353568] Key type .llcrypt registered [ 2659.981894] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 23:49:04 (1788839344) [ 2663.810027] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2663.860933] alg: No test for adler32 (adler32-zlib) [ 2665.279558] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 2665.631915] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 2667.439220] Key type lgssc registered [ 2669.349618] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2759.103087] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 2766.727719] Lustre: Unmounted lustre-client [ 2807.426748] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 23:51:32 (1788839492) [ 2944.053722] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2967.108717] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 2974.694446] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2974.703811] LustreError: 63922:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff993dc83c8000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2974.733836] Lustre: 58422:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.113@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2985.062661] Lustre: Unmounted lustre-client [ 3029.482845] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 23:55:14 (1788839714) [ 3042.987973] Key type lgssc unregistered [ 3043.206798] LNet: 65134:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3043.213097] LNetError: 65134:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3043.241806] LNet: Removed LNI 192.168.202.13@tcp [ 3043.987911] Key type .llcrypt unregistered [ 3043.990471] Key type ._llcrypt unregistered [ 3055.824746] Key type ._llcrypt registered [ 3055.826575] Key type .llcrypt registered [ 3056.316491] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3056.337397] alg: No test for adler32 (adler32-zlib) [ 3057.414948] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 3057.682808] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 3059.377529] Key type lgssc registered [ 3060.729938] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3109.225775] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3114.844616] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3135.874595] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3138.949111] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 3142.965570] Lustre: Unmounted lustre-client [ 3179.672299] Key type lgssc unregistered [ 3179.919057] LNet: 68143:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3179.928275] LNetError: 68143:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3179.960589] LNet: Removed LNI 192.168.202.13@tcp [ 3180.488601] Key type .llcrypt unregistered [ 3180.490773] Key type ._llcrypt unregistered [ 3191.465802] Key type ._llcrypt registered [ 3191.469655] Key type .llcrypt registered [ 3191.743578] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3191.759425] alg: No test for adler32 (adler32-zlib) [ 3192.829911] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 3193.021989] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 3194.687207] Key type lgssc registered [ 3195.885715] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3310.293116] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3317.319808] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3338.430052] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3341.565212] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 3349.280113] Lustre: Unmounted lustre-client [ 3379.875834] Key type lgssc unregistered [ 3380.216486] LNet: 71590:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3380.224506] LNetError: 71590:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3380.242445] LNet: Removed LNI 192.168.202.13@tcp [ 3381.013943] Key type .llcrypt unregistered [ 3381.022537] Key type ._llcrypt unregistered [ 3396.496413] Key type ._llcrypt registered [ 3396.503763] Key type .llcrypt registered [ 3397.986780] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 00:01:22 (1788840082) [ 3400.411534] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3400.434790] alg: No test for adler32 (adler32-zlib) [ 3401.518722] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 3401.928349] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 3403.631278] Key type lgssc registered [ 3404.810502] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3455.331229] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3461.353698] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3481.808082] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3484.350653] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 3495.375925] Lustre: Unmounted lustre-client [ 3495.848942] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 3500.065635] Lustre: Unmounted lustre-client [ 3531.867532] Key type lgssc unregistered [ 3532.141671] LNet: 75272:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3532.151584] LNetError: 75272:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3533.225497] LNet: Removed LNI 192.168.202.13@tcp [ 3534.108989] Key type .llcrypt unregistered [ 3534.110735] Key type ._llcrypt unregistered [ 3549.739126] Key type ._llcrypt registered [ 3549.788894] Key type .llcrypt registered [ 3550.380907] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3550.415449] alg: No test for adler32 (adler32-zlib) [ 3551.636586] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 3552.205829] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 3554.047242] Key type lgssc registered [ 3555.931579] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3607.472678] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3613.191103] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3636.106521] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3637.927967] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 3646.236554] Lustre: Unmounted lustre-client [ 3674.948482] Key type lgssc unregistered [ 3675.277467] LNet: 78305:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3675.282323] LNetError: 78305:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3676.342422] LNet: Removed LNI 192.168.202.13@tcp [ 3677.412921] Key type .llcrypt unregistered [ 3677.414517] Key type ._llcrypt unregistered [ 3693.925938] Key type ._llcrypt registered [ 3693.927646] Key type .llcrypt registered [ 3695.297527] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 00:06:20 (1788840380) [ 3698.161601] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3698.262389] alg: No test for adler32 (adler32-zlib) [ 3699.612376] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 3699.908040] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 3701.575302] Key type lgssc registered [ 3702.756743] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3758.141573] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3764.821400] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3787.964261] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3789.563598] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 3797.559794] Lustre: lustre: root_squash is set to 0:0 [ 3803.192953] Lustre: lustre: nosquash_nids is cleared [ 3803.214289] Lustre: lustre: root_squash is set to 500:500 [ 3818.035475] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.13@tcp 192.168.0.[2,10]@tcp [ 3826.750828] Lustre: lustre: nosquash_nids set to 192.168.202.13/24@tcp [ 3831.265234] Lustre: Unmounted lustre-client [ 3860.668558] Key type lgssc unregistered [ 3860.957043] LNet: 82266:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3860.974613] LNetError: 82266:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3861.008456] LNet: Removed LNI 192.168.202.13@tcp [ 3861.972204] Key type .llcrypt unregistered [ 3861.973876] Key type ._llcrypt unregistered [ 3883.164317] Key type ._llcrypt registered [ 3883.166819] Key type .llcrypt registered [ 3885.355585] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 00:09:29 (1788840569) [ 3889.291892] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3891.733926] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 00:09:36 (1788840576) [ 3894.659959] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3894.687928] alg: No test for adler32 (adler32-zlib) [ 3895.930221] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 3896.340390] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 3898.047215] Key type lgssc registered [ 3899.302427] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3953.071432] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3959.300979] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3982.842279] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3984.817777] Lustre: lustre: root_squash is set to 500:500 [ 3984.841369] Lustre: lustre: nosquash_nids set to 192.168.202.13/24@tcp [ 3985.987687] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 3991.665082] Lustre: Unmounted lustre-client [ 4020.999142] Key type lgssc unregistered [ 4021.360059] LNet: 86229:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4021.368540] LNetError: 86229:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4021.394411] LNet: Removed LNI 192.168.202.13@tcp [ 4022.137591] Key type .llcrypt unregistered [ 4022.142942] Key type ._llcrypt unregistered [ 4038.606617] Key type ._llcrypt registered [ 4038.608428] Key type .llcrypt registered [ 4040.173826] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4041.787206] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 00:12:06 (1788840726) [ 4062.982573] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4062.994392] alg: No test for adler32 (adler32-zlib) [ 4064.180679] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 4064.515385] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 4066.183886] Key type lgssc registered [ 4067.647207] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4152.666808] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4159.604967] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4183.533449] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4258.729399] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4265.220692] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4288.145428] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4304.696294] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 4340.477229] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff993dc6592800.ost_server_uuid 50 [ 4342.144700] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff993dc6592800.ost_server_uuid in IDLE state after 0 sec [ 4342.666575] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 4345.922179] Lustre: Unmounted lustre-client [ 4347.727968] Lustre: Unmounted lustre-client [ 4389.477761] Key type lgssc unregistered [ 4389.894307] LNet: 93899:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4389.901665] LNetError: 93899:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4389.933308] LNet: Removed LNI 192.168.202.13@tcp [ 4390.966188] Key type .llcrypt unregistered [ 4390.968511] Key type ._llcrypt unregistered [ 4426.267693] Key type ._llcrypt registered [ 4426.276255] Key type .llcrypt registered [ 4427.923510] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 00:18:32 (1788841112) [ 4446.683133] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4446.729303] alg: No test for adler32 (adler32-zlib) [ 4447.937807] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 4448.274419] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 4449.967428] Key type lgssc registered [ 4451.767229] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4532.737247] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4538.357429] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4564.809345] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4566.644302] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 4586.975236] Lustre: 95260:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788841257/real 1788841257] req@00000000a9b3fb6d x1875735880930432/t0(0) o400->lustre-OST0000-osc-ffff993dc41a4000@192.168.202.113@tcp:28/4 lens 224/224 e 0 to 1 dl 1788841273 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4587.005913] Lustre: lustre-OST0000-osc-ffff993dc41a4000: Connection to lustre-OST0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4593.119216] Lustre: 95261:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788841263/real 1788841263] req@000000005aa7e917 x1875735880930944/t0(0) o400->lustre-OST0000-osc-ffff993dc41a4000@192.168.202.113@tcp:28/4 lens 224/224 e 0 to 1 dl 1788841279 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4597.855790] Lustre: 95260:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788841268/real 1788841268] req@00000000e26414cc x1875735880931456/t0(0) o400->lustre-OST0000-osc-ffff993dc41a4000@192.168.202.113@tcp:28/4 lens 224/224 e 0 to 1 dl 1788841284 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4598.894762] Lustre: lustre-OST0000-osc-ffff993dc41a4000: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [ 4603.359188] Lustre: 95261:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788841273/real 1788841273] req@000000005e7ae6c3 x1875735880931968/t0(0) o400->lustre-OST0000-osc-ffff993dc41a4000@192.168.202.113@tcp:28/4 lens 224/224 e 0 to 1 dl 1788841289 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4607.479630] Lustre: lustre-MDT0000-mdc-ffff993dc41a4000: Connection to lustre-MDT0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4622.815219] Lustre: 95260:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788841293/real 1788841293] req@0000000078ed0fb2 x1875735880934784/t0(0) o400->MGC192.168.202.113@tcp@192.168.202.113@tcp:26/25 lens 224/224 e 0 to 1 dl 1788841309 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4622.846818] LustreError: MGC192.168.202.113@tcp: Connection to MGS (at 192.168.202.113@tcp) was lost; in progress operations using this service will fail [ 4628.806415] Lustre: lustre-MDT0000-mdc-ffff993dc41a4000: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [ 4633.108407] Lustre: Evicted from MGS (at 192.168.202.113@tcp) after server handle changed from 0x5e187eb39f728030 to 0x5e187eb39f72845f [ 4633.119203] Lustre: MGC192.168.202.113@tcp: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [ 4634.557629] Lustre: Unmounted lustre-client [ 4661.696586] Key type lgssc unregistered [ 4661.943920] LNet: 99560:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4661.962801] LNetError: 99560:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4661.988768] LNet: Removed LNI 192.168.202.13@tcp [ 4662.674306] Key type .llcrypt unregistered [ 4662.677651] Key type ._llcrypt unregistered [ 4679.769760] Key type ._llcrypt registered [ 4679.772336] Key type .llcrypt registered [ 4681.019446] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 00:22:45 (1788841365) [ 4696.252060] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4696.300584] alg: No test for adler32 (adler32-zlib) [ 4697.529849] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 4697.746979] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 4699.535942] Key type lgssc registered [ 4701.479669] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4744.212996] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4850.702677] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4858.096888] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4882.606996] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4885.413409] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 4887.619247] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4889.547251] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 00:26:14 (1788841574) [ 5151.153644] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5161.558853] Lustre: Unmounted lustre-client [ 5294.410149] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5300.226523] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5324.546496] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5377.188730] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 00:34:21 (1788842061) [ 5484.926418] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5491.918214] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5518.501162] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5519.151220] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 5523.950351] Lustre: Unmounted lustre-client [ 5565.530620] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 00:37:30 (1788842250) [ 5676.162775] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5683.862761] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5710.581705] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5711.450452] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 5716.839508] Lustre: Unmounted lustre-client [ 5745.839294] Key type lgssc unregistered [ 5746.096861] LNet: 122612:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5746.111507] LNetError: 122612:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5746.146113] LNet: Removed LNI 192.168.202.13@tcp [ 5746.865345] Key type .llcrypt unregistered [ 5746.867655] Key type ._llcrypt unregistered [ 5763.349562] Key type ._llcrypt registered [ 5763.351878] Key type .llcrypt registered [ 5764.701891] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 00:40:49 (1788842449) [ 5767.308881] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5767.355609] alg: No test for adler32 (adler32-zlib) [ 5768.453389] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 5768.770487] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 5770.503266] Key type lgssc registered [ 5771.930267] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5820.356296] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5825.552980] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5848.418198] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5850.347985] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 5867.562673] Lustre: Unmounted lustre-client [ 5895.104420] Key type lgssc unregistered [ 5895.340905] LNet: 126202:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5895.347415] LNetError: 126202:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5895.364734] LNet: Removed LNI 192.168.202.13@tcp [ 5896.265610] Key type .llcrypt unregistered [ 5896.273280] Key type ._llcrypt unregistered [ 5912.348192] Key type ._llcrypt registered [ 5912.351851] Key type .llcrypt registered [ 5913.684414] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 00:43:18 (1788842598) [ 5916.686511] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5916.728079] alg: No test for adler32 (adler32-zlib) [ 5918.067948] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 5918.354207] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 5920.121042] Key type lgssc registered [ 5921.792412] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5974.762662] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5980.736165] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6003.776388] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6005.307701] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 6020.389489] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff993dc8b7c800.ost_server_uuid 50 [ 6030.815240] Lustre: 127160:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788842701/real 1788842701] req@0000000054c43fe9 x1875737422337792/t0(0) o400->lustre-OST0000-osc-ffff993dc8b7c800@192.168.202.113@tcp:28/4 lens 224/224 e 0 to 1 dl 1788842717 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 6030.849822] Lustre: lustre-OST0000-osc-ffff993dc8b7c800: Connection to lustre-OST0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6033.450712] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6035.976146] Lustre: 127160:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788842706/real 1788842706] req@00000000ffe67f01 x1875737422338304/t0(0) o400->lustre-OST0000-osc-ffff993dc8b7c800@192.168.202.113@tcp:28/4 lens 224/224 e 0 to 1 dl 1788842722 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 6042.080925] Lustre: 127160:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788842712/real 1788842712] req@00000000f0569cae x1875737422338816/t0(0) o400->lustre-OST0000-osc-ffff993dc8b7c800@192.168.202.113@tcp:28/4 lens 224/224 e 0 to 1 dl 1788842728 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 6045.791032] Lustre: Unmounted lustre-client [ 6071.158797] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 00:45:55 (1788842755) [ 6108.654887] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6115.363653] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6142.768207] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6169.273668] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6169.845198] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 6175.229858] Lustre: lustre-OST0000-osc-ffff993dd08d5000: Connection to lustre-OST0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6210.396774] Lustre: Unmounted lustre-client [ 6259.923652] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 00:49:04 (1788842944) [ 6293.771433] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6300.367741] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6326.505318] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6350.779995] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6351.613593] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 6356.977850] Lustre: lustre-OST0000-osc-ffff993dd81a3800: Connection to lustre-OST0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6373.952654] Lustre: Unmounted lustre-client [ 6424.544914] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 00:51:49 (1788843109) [ 6539.290557] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6546.754232] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6575.388912] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6655.063168] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6662.723860] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6692.348800] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6728.393254] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 6776.163989] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6778.831962] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6780.100731] Lustre: Unmounted lustre-client [ 6814.638522] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 00:58:19 (1788843499) [ 6855.231188] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6862.402747] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6887.097636] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6927.595278] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6962.564152] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 7010.673738] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7012.270674] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7025.620678] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7036.010713] Lustre: Unmounted lustre-client [ 7111.417763] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 01:03:15 (1788843795) [ 7145.781864] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7152.614159] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7178.022985] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7178.717174] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 7205.876693] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7208.056645] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7226.033785] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff993dd08d0800.ost_server_uuid 50 [ 7227.739609] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff993dd08d0800.ost_server_uuid in IDLE state after 0 sec [ 7231.543295] Lustre: Unmounted lustre-client [ 7231.950632] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7231.958064] Lustre: Skipped 3 previous similar messages [ 7232.108963] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 7233.554285] LustreError: 149733:0:(sec.c:403:import_sec_validate_get()) import 00000000dd1e5a4e (NEW) with no sec [ 7316.059959] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 01:06:40 (1788844000) [ 7355.574375] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7361.972406] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7386.435055] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7410.373025] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7410.929942] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7411.127401] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 7423.882755] Lustre: Unmounted lustre-client [ 7423.887497] Lustre: Skipped 1 previous similar message [ 7464.880385] Key type lgssc unregistered [ 7465.170694] LNet: 153143:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7465.177284] LNetError: 153143:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7465.202486] LNet: Removed LNI 192.168.202.13@tcp [ 7466.056926] Key type .llcrypt unregistered [ 7466.060519] Key type ._llcrypt unregistered [ 7483.331447] Key type ._llcrypt registered [ 7483.333083] Key type .llcrypt registered [ 7484.942497] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 01:09:29 (1788844169) [ 7486.070632] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7486.102080] alg: No test for adler32 (adler32-zlib) [ 7487.102888] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 7487.299833] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 7488.999323] Key type lgssc registered [ 7490.054153] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7541.762668] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7546.859968] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7568.930256] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7590.114890] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7591.571344] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7592.788811] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 7598.662690] LustreError: lustre-MDT0001-mdc-ffff993de0315800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7598.675509] Lustre: lustre-MDT0001-mdc-ffff993de0315800: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [ 7604.765423] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7606.853335] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7631.401347] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7635.573136] Lustre: Unmounted lustre-client [ 7667.298584] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 01:12:31 (1788844351) [ 7763.325969] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7769.744534] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7793.326532] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7793.774923] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 7824.383415] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7826.001876] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7838.963982] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7849.321078] Lustre: Unmounted lustre-client [ 7893.132327] Key type lgssc unregistered [ 7893.397526] LNet: 162753:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7893.404670] LNetError: 162753:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7893.429008] LNet: Removed LNI 192.168.202.13@tcp [ 7894.361056] Key type .llcrypt unregistered [ 7894.363150] Key type ._llcrypt unregistered [ 7928.979490] Key type ._llcrypt registered [ 7928.984590] Key type .llcrypt registered [ 7930.708635] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 01:16:54 (1788844614) [ 7933.901341] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7934.029883] alg: No test for adler32 (adler32-zlib) [ 7935.188164] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 7935.600967] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 7937.344038] Key type lgssc registered [ 7938.742155] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8001.044879] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8008.316231] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8032.382756] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8034.178542] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 8082.328836] Lustre: Unmounted lustre-client [ 8126.957898] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8127.582541] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 8164.971120] Lustre: Unmounted lustre-client [ 8194.518736] Key type lgssc unregistered [ 8194.773269] LNet: 167194:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8194.781695] LNetError: 167194:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8194.821251] LNet: Removed LNI 192.168.202.13@tcp [ 8195.902707] Key type .llcrypt unregistered [ 8195.904983] Key type ._llcrypt unregistered [ 8214.290963] Key type ._llcrypt registered [ 8214.294963] Key type .llcrypt registered [ 8216.201407] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 01:21:40 (1788844900) [ 8219.201954] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8219.471317] alg: No test for adler32 (adler32-zlib) [ 8220.844105] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 8221.226669] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 8222.999237] Key type lgssc registered [ 8224.752541] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8291.158775] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8298.206180] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8327.172557] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8333.359491] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 8352.375188] Lustre: Unmounted lustre-client [ 8382.657300] Key type lgssc unregistered [ 8383.050850] LNet: 170947:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8383.065901] LNetError: 170947:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8384.105826] LNet: Removed LNI 192.168.202.13@tcp [ 8385.049587] Key type .llcrypt unregistered [ 8385.051884] Key type ._llcrypt unregistered [ 8403.652053] Key type ._llcrypt registered [ 8403.657785] Key type .llcrypt registered [ 8404.343764] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8404.367661] alg: No test for adler32 (adler32-zlib) [ 8405.406172] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 8405.760120] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 8407.479227] Key type lgssc registered [ 8410.350505] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8468.474785] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8475.653333] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8498.853888] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8500.710164] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 8510.649756] Lustre: Unmounted lustre-client [ 8537.948257] Key type lgssc unregistered [ 8538.233983] LNet: 174009:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8538.257147] LNetError: 174009:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8538.282305] LNet: Removed LNI 192.168.202.13@tcp [ 8538.921201] Key type .llcrypt unregistered [ 8538.923621] Key type ._llcrypt unregistered [ 8557.176463] Key type ._llcrypt registered [ 8557.181416] Key type .llcrypt registered [ 8558.631305] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 01:27:23 (1788845243) [ 8562.300488] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8562.338990] alg: No test for adler32 (adler32-zlib) [ 8563.876585] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 8564.340201] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 8566.064482] Key type lgssc registered [ 8567.929469] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8631.840139] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8639.413045] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8664.561872] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8671.831399] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 8692.887941] Lustre: Unmounted lustre-client [ 8724.759492] Key type lgssc unregistered [ 8724.982413] LNet: 177762:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8724.988918] LNetError: 177762:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8725.007162] LNet: Removed LNI 192.168.202.13@tcp [ 8725.685918] Key type .llcrypt unregistered [ 8725.688167] Key type ._llcrypt unregistered [ 8737.637742] Key type ._llcrypt registered [ 8737.701068] Key type .llcrypt registered [ 8738.124500] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8738.134332] alg: No test for adler32 (adler32-zlib) [ 8739.424578] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 8739.778039] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 8741.519419] Key type lgssc registered [ 8743.083359] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8802.759788] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8808.396489] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8830.335942] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8831.910152] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 8839.430363] Lustre: Unmounted lustre-client [ 8880.086393] Key type lgssc unregistered [ 8880.506793] LNet: 180820:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8880.515655] LNetError: 180820:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8880.558706] LNet: Removed LNI 192.168.202.13@tcp [ 8881.664201] Key type .llcrypt unregistered [ 8881.670145] Key type ._llcrypt unregistered [ 8907.538276] Key type ._llcrypt registered [ 8907.540207] Key type .llcrypt registered [ 8909.267574] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 01:33:13 (1788845593) [ 8932.338783] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8932.369299] alg: No test for adler32 (adler32-zlib) [ 8933.472261] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 8933.703098] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 8935.359516] Key type lgssc registered [ 8936.527328] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9023.287762] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9029.356898] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9056.568483] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9110.025569] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 01:36:34 (1788845794) [ 9145.899800] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9151.757462] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9174.281348] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9177.229698] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 9185.787227] Lustre: Unmounted lustre-client [ 9223.571720] Key type lgssc unregistered [ 9223.950584] LNet: 187921:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9223.968559] LNetError: 187921:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9223.992507] LNet: Removed LNI 192.168.202.13@tcp [ 9224.692729] Key type .llcrypt unregistered [ 9224.696887] Key type ._llcrypt unregistered [ 9241.759416] Key type ._llcrypt registered [ 9241.765025] Key type .llcrypt registered [ 9243.007711] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9244.708489] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 01:38:49 (1788845929) [ 9262.957233] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9262.982647] alg: No test for adler32 (adler32-zlib) [ 9263.979747] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 9264.171960] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 9265.856587] Key type lgssc registered [ 9266.923690] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9365.814148] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9372.632172] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9398.654352] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9424.211270] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9427.269642] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [ 9454.631830] Lustre: Unmounted lustre-client [ 9592.875461] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9600.951048] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9629.980531] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9683.423181] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 01:46:06 (1788846366) [ 9685.121992] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9687.432211] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 01:46:12 (1788846372) [ 9799.321906] Key type lgssc unregistered [ 9799.729097] LNet: 199368:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9799.742376] LNetError: 199368:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9799.773849] LNet: Removed LNI 192.168.202.13@tcp [ 9800.541296] Key type .llcrypt unregistered [ 9800.543282] Key type ._llcrypt unregistered [ 9818.517449] Key type ._llcrypt registered [ 9818.524950] Key type .llcrypt registered [ 9820.033656] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 01:48:24 (1788846504) [ 9868.421847] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9868.444748] alg: No test for adler32 (adler32-zlib) [ 9869.489145] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [ 9869.701512] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [ 9871.367256] Key type lgssc registered [ 9872.660863] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9927.284153] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9933.812368] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9969.396800] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9999.814907] Key type lgssc unregistered [10000.072604] LNet: 203099:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10000.079454] LNetError: 203099:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10000.098526] LNet: Removed LNI 192.168.202.13@tcp [10000.946076] Key type .llcrypt unregistered [10000.947687] Key type ._llcrypt unregistered [10019.967490] Key type ._llcrypt registered [10019.969608] Key type .llcrypt registered [10021.496443] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 01:51:46 (1788846706) [10024.804797] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10024.817768] alg: No test for adler32 (adler32-zlib) [10026.000960] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [10026.304850] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [10027.967309] Key type lgssc registered [10029.338682] Lustre: Echo OBD driver; http://www.lustre.org/ [10081.672322] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10088.398308] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10115.194108] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10118.395488] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [10128.872520] Lustre: lustre-MDT0000-mdc-ffff993de0313000: Connection to lustre-MDT0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [10139.123667] Lustre: lustre-MDT0001-mdc-ffff993de0313000: Connection to lustre-MDT0001 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [10150.368730] Lustre: 204089:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788846820/real 1788846820] req@00000000553ba306 x1875741729964032/t0(0) o400->MGC192.168.202.113@tcp@192.168.202.113@tcp:26/25 lens 224/224 e 0 to 1 dl 1788846836 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10150.387656] LustreError: MGC192.168.202.113@tcp: Connection to MGS (at 192.168.202.113@tcp) was lost; in progress operations using this service will fail [10175.015102] Lustre: Evicted from MGS (at 192.168.202.113@tcp) after server handle changed from 0x44f886abdabfc9f9 to 0x44f886abdabfe33d [10175.030662] Lustre: MGC192.168.202.113@tcp: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [10204.676381] LustreError: lustre-MDT0000-mdc-ffff993de0313000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10204.748169] Lustre: lustre-MDT0000-mdc-ffff993de0313000: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [10212.615358] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10215.210568] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10221.699723] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10224.010683] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10227.663926] Lustre: Unmounted lustre-client [10267.898245] Key type lgssc unregistered [10268.256811] LNet: 208054:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10268.272188] LNetError: 208054:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10268.308895] LNet: Removed LNI 192.168.202.13@tcp [10269.408759] Key type .llcrypt unregistered [10269.414267] Key type ._llcrypt unregistered [10291.245815] Key type ._llcrypt registered [10291.247535] Key type .llcrypt registered [10292.623892] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 01:56:17 (1788846977) [10295.828455] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10295.865457] alg: No test for adler32 (adler32-zlib) [10297.113361] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [10297.474433] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [10299.211897] Key type lgssc registered [10300.963754] Lustre: Echo OBD driver; http://www.lustre.org/ [10361.238920] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10367.563409] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10439.662625] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10445.579939] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10486.399537] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10512.023524] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10559.883977] Key type lgssc unregistered [10560.054968] LNet: 213353:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10560.064695] LNetError: 213353:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10560.081932] LNet: Removed LNI 192.168.202.13@tcp [10560.675861] Key type .llcrypt unregistered [10560.682961] Key type ._llcrypt unregistered [10607.135972] Key type ._llcrypt registered [10607.139529] Key type .llcrypt registered [10608.907062] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 02:01:33 (1788847293) [10652.582128] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10652.622231] alg: No test for adler32 (adler32-zlib) [10653.804615] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [10654.256400] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [10655.987387] Key type lgssc registered [10658.190065] Lustre: Echo OBD driver; http://www.lustre.org/ [10751.161377] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10759.202560] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10782.969275] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10827.303583] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 02:05:11 (1788847511) [10835.744952] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 02:05:20 (1788847520) [10872.217576] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10880.635963] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10909.110448] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10915.924857] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [10921.933607] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10924.033892] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10925.787572] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10927.636755] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10931.179114] Lustre: lustre-MDT0000-mdc-ffff993dd1f3b800: Connection to lustre-MDT0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [10947.552502] Lustre: 215259:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788847617/real 1788847617] req@00000000865a9838 x1875742388397568/t0(0) o400->MGC192.168.202.113@tcp@192.168.202.113@tcp:26/25 lens 224/224 e 0 to 1 dl 1788847633 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10947.617298] LustreError: MGC192.168.202.113@tcp: Connection to MGS (at 192.168.202.113@tcp) was lost; in progress operations using this service will fail [10956.788132] Lustre: Evicted from MGS (at 192.168.202.113@tcp) after server handle changed from 0xbfebd39a47be6795 to 0xbfebd39a47be690f [10956.803323] Lustre: MGC192.168.202.113@tcp: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [10963.765740] Lustre: lustre-MDT0000-mdc-ffff993dd1f3b800: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [10975.585554] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10977.430586] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10981.728156] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10987.529458] Lustre: lustre-MDT0000-mdc-ffff993dd1f3b800: Connection to lustre-MDT0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [11003.872188] Lustre: 215259:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788847673/real 1788847673] req@000000008be38f31 x1875742388407424/t0(0) o400->MGC192.168.202.113@tcp@192.168.202.113@tcp:26/25 lens 224/224 e 0 to 1 dl 1788847689 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11003.928330] LustreError: MGC192.168.202.113@tcp: Connection to MGS (at 192.168.202.113@tcp) was lost; in progress operations using this service will fail [11014.139906] Lustre: Evicted from MGS (at 192.168.202.113@tcp) after server handle changed from 0xbfebd39a47be690f to 0xbfebd39a47be6cff [11014.150227] Lustre: MGC192.168.202.113@tcp: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [11020.659610] Lustre: lustre-MDT0000-mdc-ffff993dd1f3b800: Connection restored to 192.168.202.113@tcp (at 192.168.202.113@tcp) [11029.426569] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11031.053424] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11034.752182] Lustre: Unmounted lustre-client [11111.946648] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11121.156384] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11148.909300] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11155.032519] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [11157.988921] Lustre: Unmounted lustre-client [11186.375695] Key type lgssc unregistered [11186.878778] LNet: 225852:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11186.887446] LNetError: 225852:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11186.915636] LNet: Removed LNI 192.168.202.13@tcp [11188.227166] Key type .llcrypt unregistered [11188.233947] Key type ._llcrypt unregistered [11205.301356] Key type ._llcrypt registered [11205.304574] Key type .llcrypt registered [11207.214222] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 02:11:31 (1788847891) [11212.115232] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11212.363577] alg: No test for adler32 (adler32-zlib) [11213.430905] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [11213.689065] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [11215.439204] Key type lgssc registered [11216.896519] Lustre: Echo OBD driver; http://www.lustre.org/ [11266.624632] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11271.504817] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11292.870031] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11294.598466] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [11300.747237] Lustre: Unmounted lustre-client [11364.222327] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11371.196424] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11391.976886] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11392.766626] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [11402.832466] Lustre: Unmounted lustre-client [11480.515945] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11486.611649] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11511.305524] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11511.963377] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [11515.020812] Lustre: Unmounted lustre-client [11551.315478] Key type lgssc unregistered [11551.604573] LNet: 232908:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11551.608937] LNetError: 232908:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11551.628916] LNet: Removed LNI 192.168.202.13@tcp [11552.467748] Key type .llcrypt unregistered [11552.471974] Key type ._llcrypt unregistered [11569.183458] Key type ._llcrypt registered [11569.187678] Key type .llcrypt registered [11570.871855] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 02:17:35 (1788848255) [11574.562883] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11574.762321] alg: No test for adler32 (adler32-zlib) [11575.888025] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [11576.168038] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [11577.903401] Key type lgssc registered [11579.118819] Lustre: Echo OBD driver; http://www.lustre.org/ [11623.877946] Key type lgssc unregistered [11624.168591] LNet: 235227:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11624.177185] LNetError: 235227:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11624.194072] LNet: Removed LNI 192.168.202.13@tcp [11625.132961] Key type .llcrypt unregistered [11625.141406] Key type ._llcrypt unregistered [11655.190088] Key type ._llcrypt registered [11655.191769] Key type .llcrypt registered [11655.898934] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11655.920286] alg: No test for adler32 (adler32-zlib) [11657.000636] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [11657.282367] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [11658.951830] Key type lgssc registered [11660.133319] Lustre: Echo OBD driver; http://www.lustre.org/ [11743.243402] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11750.022629] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11774.603340] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11816.723710] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11819.469576] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 02:21:43 (1788848503) [11852.755395] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11861.273780] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11889.655608] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11914.948920] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11917.979431] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [11923.455872] Lustre: lustre-OST0001-osc-ffff993dd0eab000: Connection to lustre-OST0001 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [11931.453952] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11941.846656] Lustre: Unmounted lustre-client [11979.552298] Key type lgssc unregistered [11979.866943] LNet: 242341:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11979.880501] LNetError: 242341:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11979.916827] LNet: Removed LNI 192.168.202.13@tcp [11980.929920] Key type .llcrypt unregistered [11980.936054] Key type ._llcrypt unregistered [12014.935712] Key type ._llcrypt registered [12014.939637] Key type .llcrypt registered [12016.474955] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 02:25:01 (1788848701) [12032.189332] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12032.403090] alg: No test for adler32 (adler32-zlib) [12033.725771] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [12034.080850] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [12035.897595] Key type lgssc registered [12037.348527] Lustre: Echo OBD driver; http://www.lustre.org/ [12093.080172] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12100.597581] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12123.965483] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 02:26:48 (1788848808) [12161.367443] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12167.718464] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12194.769211] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12197.693124] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [12208.648509] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12215.376306] Lustre: Unmounted lustre-client [12314.807879] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12319.922104] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12372.099846] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12372.839937] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [12375.404659] Lustre: Unmounted lustre-client [12412.182766] Key type lgssc unregistered [12412.597327] LNet: 250053:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12412.606436] LNetError: 250053:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12412.630484] LNet: Removed LNI 192.168.202.13@tcp [12413.525956] Key type .llcrypt unregistered [12413.527965] Key type ._llcrypt unregistered [12441.399962] Key type ._llcrypt registered [12441.403427] Key type .llcrypt registered [12442.017685] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12442.032655] alg: No test for adler32 (adler32-zlib) [12443.378887] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [12443.716604] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [12445.623215] Key type lgssc registered [12446.864127] Lustre: Echo OBD driver; http://www.lustre.org/ [12532.675036] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12538.694294] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12562.260505] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12602.340996] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12604.417799] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 02:34:48 (1788849288) [12636.384668] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12642.420208] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12661.721643] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12666.480181] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [12668.933496] Lustre: Unmounted lustre-client [12702.244699] Key type lgssc unregistered [12702.539422] LNet: 256683:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12702.548236] LNetError: 256683:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12702.575109] LNet: Removed LNI 192.168.202.13@tcp [12703.231875] Key type .llcrypt unregistered [12703.234328] Key type ._llcrypt unregistered [12716.041752] Key type ._llcrypt registered [12716.046159] Key type .llcrypt registered [12717.050481] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12718.573812] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 02:36:43 (1788849403) [12726.524647] Key type .llcrypt unregistered [12726.528777] Key type ._llcrypt unregistered [12734.270341] Key type ._llcrypt registered [12734.271596] Key type .llcrypt registered [12735.060203] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12735.073822] alg: No test for adler32 (adler32-zlib) [12736.145816] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [12736.386084] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [12738.023247] Key type lgssc registered [12739.267658] Lustre: Echo OBD driver; http://www.lustre.org/ [12793.242431] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12808.121791] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [12811.238417] Lustre: Unmounted lustre-client [12838.997573] Key type lgssc unregistered [12839.247750] LNet: 260133:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12839.254920] LNetError: 260133:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12839.280591] LNet: Removed LNI 192.168.202.13@tcp [12839.925108] Key type .llcrypt unregistered [12839.928103] Key type ._llcrypt unregistered [12851.876423] Key type ._llcrypt registered [12851.881426] Key type .llcrypt registered [12852.966608] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 02:38:58 (1788849538) [12854.712947] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12854.729281] alg: No test for adler32 (adler32-zlib) [12855.856648] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [12856.101638] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [12857.768109] Key type lgssc registered [12858.717490] Lustre: Echo OBD driver; http://www.lustre.org/ [12937.598513] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12966.694754] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12971.347046] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12973.975280] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [12975.607291] Lustre: Unmounted lustre-client [13001.758364] Key type lgssc unregistered [13002.006770] LNet: 263668:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13002.021659] LNetError: 263668:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13002.044522] LNet: Removed LNI 192.168.202.13@tcp [13002.901950] Key type .llcrypt unregistered [13002.906518] Key type ._llcrypt unregistered [13016.905616] Key type ._llcrypt registered [13016.908482] Key type .llcrypt registered [13017.982567] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 02:41:43 (1788849703) [13020.099427] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13020.146759] alg: No test for adler32 (adler32-zlib) [13021.347312] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [13021.670294] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [13023.423334] Key type lgssc registered [13024.667176] Lustre: Echo OBD driver; http://www.lustre.org/ [13070.351648] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13075.482648] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13095.162956] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13096.860530] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [13102.064187] Lustre: lustre-MDT0000-mdc-ffff993dc43a4800: Connection to lustre-MDT0000 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [13106.605694] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13106.634805] LustreError: 266831:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13106.884110] LustreError: MGC192.168.202.113@tcp: Connection to MGS (at 192.168.202.113@tcp) was lost; in progress operations using this service will fail [13106.939047] Lustre: Unmounted lustre-client [13124.368599] Key type lgssc unregistered [13124.572599] LNet: 267242:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13124.598898] LNetError: 267242:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13124.617132] LNet: Removed LNI 192.168.202.13@tcp [13125.224092] Key type .llcrypt unregistered [13125.226377] Key type ._llcrypt unregistered [13139.256719] Key type ._llcrypt registered [13139.259099] Key type .llcrypt registered [13140.313628] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 02:43:45 (1788849825) [13142.181878] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13142.213057] alg: No test for adler32 (adler32-zlib) [13143.255418] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [13143.530305] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [13145.183214] Key type lgssc registered [13146.218525] Lustre: Echo OBD driver; http://www.lustre.org/ [13190.729103] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13196.516072] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13216.527982] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13219.210341] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [13224.437174] Lustre: lustre-MDT0001-mdc-ffff993dc7d4e800: Connection to lustre-MDT0001 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [13229.631936] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13232.011208] Lustre: Unmounted lustre-client [13249.891797] Key type lgssc unregistered [13250.134874] LNet: 270816:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13250.141065] LNetError: 270816:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13250.155727] LNet: Removed LNI 192.168.202.13@tcp [13250.876360] Key type .llcrypt unregistered [13250.877843] Key type ._llcrypt unregistered [13263.550233] Key type ._llcrypt registered [13263.552254] Key type .llcrypt registered [13264.471954] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 02:45:49 (1788849949) [13281.004603] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13281.063196] alg: No test for adler32 (adler32-zlib) [13282.163578] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [13282.386428] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [13284.079363] Key type lgssc registered [13285.441649] Lustre: Echo OBD driver; http://www.lustre.org/ [13382.874889] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13384.441362] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [13419.500525] Lustre: lustre-MDT0001-mdc-ffff993dd8ac2000: Connection to lustre-MDT0001 (at 192.168.202.113@tcp) was lost; in progress operations using this service will wait for recovery to complete [13427.899240] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13438.249577] Lustre: Unmounted lustre-client [13480.465639] Key type lgssc unregistered [13480.708368] LNet: 276600:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13480.713932] LNetError: 276600:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13480.729644] LNet: Removed LNI 192.168.202.13@tcp [13481.304451] Key type .llcrypt unregistered [13481.309676] Key type ._llcrypt unregistered [13494.619838] Key type ._llcrypt registered [13494.621802] Key type .llcrypt registered [13495.859189] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 02:49:40 (1788850180) [13497.375452] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13498.879714] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 02:49:44 (1788850184) [13500.314984] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13501.846523] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 02:49:47 (1788850187) [13503.553463] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13505.130065] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 02:49:50 (1788850190) [13506.512686] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13507.870316] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 02:49:53 (1788850193) [13509.712875] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13511.358828] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 02:49:56 (1788850196) [13519.544542] Key type .llcrypt unregistered [13519.547748] Key type ._llcrypt unregistered [13526.352354] Key type ._llcrypt registered [13526.355371] Key type .llcrypt registered [13526.969456] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13526.992267] alg: No test for adler32 (adler32-zlib) [13528.072342] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [13528.327272] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [13530.023311] Key type lgssc registered [13530.901162] Lustre: Echo OBD driver; http://www.lustre.org/ [13587.334631] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13592.366314] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13610.663319] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13613.273868] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [13615.089601] Lustre: Unmounted lustre-client [13648.304838] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 02:52:13 (1788850333) [13675.105917] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13679.731503] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13708.560228] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13708.985887] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [13710.127210] Lustre: Unmounted lustre-client [13747.890886] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 02:53:53 (1788850433) [13766.943566] LNet: 1 local NIs in recovery (showing 1): 192.168.202.13@tcp [14395.992319] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14402.995805] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14439.122245] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14552.573569] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 03:07:17 (1788851237) [14565.378553] Key type lgssc unregistered [14565.692781] LNet: 290125:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14565.697819] LNetError: 290125:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14566.765364] LNet: Removed LNI 192.168.202.13@tcp [14567.955123] Key type .llcrypt unregistered [14567.960950] Key type ._llcrypt unregistered [14691.125214] Key type ._llcrypt registered [14691.127957] Key type .llcrypt registered [14691.642860] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14691.656792] alg: No test for adler32 (adler32-zlib) [14692.827598] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [14693.150792] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [14694.895334] Key type lgssc registered [14696.962987] Lustre: Echo OBD driver; http://www.lustre.org/ [14796.034724] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14804.616327] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14834.899098] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14871.521660] Key type lgssc unregistered [14871.743801] LNet: 293824:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14871.754169] LNetError: 293824:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14871.769132] LNet: Removed LNI 192.168.202.13@tcp [14872.821881] Key type .llcrypt unregistered [14872.829270] Key type ._llcrypt unregistered [14912.392421] Key type ._llcrypt registered [14912.395985] Key type .llcrypt registered [14914.029355] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 03:13:18 (1788851598) [14940.389666] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14940.430772] alg: No test for adler32 (adler32-zlib) [14941.811416] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [14942.058627] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [14943.767237] Key type lgssc registered [14945.191522] Lustre: Echo OBD driver; http://www.lustre.org/ [15014.917204] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 03:14:59 (1788851699) [15029.969037] Key type lgssc unregistered [15030.262924] LNet: 297380:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15030.270091] LNetError: 297380:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15030.297984] LNet: Removed LNI 192.168.202.13@tcp [15031.312981] Key type .llcrypt unregistered [15031.318358] Key type ._llcrypt unregistered [15046.962145] Key type ._llcrypt registered [15046.965841] Key type .llcrypt registered [15047.647730] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15047.697231] alg: No test for adler32 (adler32-zlib) [15048.992696] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [15049.327842] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [15051.118559] Key type lgssc registered [15052.557336] Lustre: Echo OBD driver; http://www.lustre.org/ [15117.069156] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15123.373484] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15150.250630] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15496.105466] LNet: Added LNI 192.168.202.13@tcp50 [8/256/0/180] [15499.530638] LNet: Removed LNI 192.168.202.13@tcp [15502.103910] Lustre: 301799:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff993dd0fce000: config has no valid NIDs, force dynamic NIDs [15503.349818] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [15503.567398] Lustre: Unmounted lustre-client [15506.295469] Key type lgssc unregistered [15506.649504] LNet: 302057:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15506.658937] LNetError: 302057:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15507.685773] LNet: Removed LNI 192.168.202.13@tcp50 [15508.259367] Key type .llcrypt unregistered [15508.261290] Key type ._llcrypt unregistered [15535.227137] Key type ._llcrypt registered [15535.232336] Key type .llcrypt registered [15535.444190] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15535.459595] alg: No test for adler32 (adler32-zlib) [15536.680519] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [15537.079281] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [15538.807352] Key type lgssc registered [15540.311708] Lustre: Echo OBD driver; http://www.lustre.org/ [15608.625886] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15613.577829] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15623.262693] LNet: Added LNI 192.168.202.13@tcp50 [8/256/0/180] [15624.203892] LNet: Removed LNI 192.168.202.13@tcp [15625.412249] Lustre: 304744:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff993dc59a3800: config has no valid NIDs, force dynamic NIDs [15626.818089] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [15627.531135] Lustre: Unmounted lustre-client [15663.428732] Key type lgssc unregistered [15663.928950] LNet: 305612:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15663.942781] LNetError: 305612:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15663.961743] LNet: Removed LNI 192.168.202.13@tcp50 [15664.832330] Key type .llcrypt unregistered [15664.834402] Key type ._llcrypt unregistered [15678.101457] Key type ._llcrypt registered [15678.107289] Key type .llcrypt registered [15679.919723] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 03:26:04 (1788852364) [15703.765521] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15703.827304] alg: No test for adler32 (adler32-zlib) [15705.233485] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [15705.452191] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [15707.103216] Key type lgssc registered [15708.475927] Lustre: Echo OBD driver; http://www.lustre.org/ [15808.984984] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15816.386618] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15846.762338] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15886.338706] Key type lgssc unregistered [15886.709722] LNet: 310359:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15886.723689] LNetError: 310359:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15886.744963] LNet: Removed LNI 192.168.202.13@tcp [15887.754617] Key type .llcrypt unregistered [15887.755940] Key type ._llcrypt unregistered [15901.371511] Key type ._llcrypt registered [15901.379715] Key type .llcrypt registered [15903.025589] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 03:29:47 (1788852587) [15905.969309] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15905.976286] alg: No test for adler32 (adler32-zlib) [15907.020422] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [15907.306723] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [15909.024660] Key type lgssc registered [15911.099312] Lustre: Echo OBD driver; http://www.lustre.org/ [15962.750915] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15969.374527] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15994.268412] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15997.117762] Lustre: Mounted lustre-client - version 2.17.57_113_gf5ca795 [16061.649202] Lustre: Mounted fs15246-client - version 2.17.57_113_gf5ca795 [16079.230563] Lustre: Unmounted fs15246-client [16114.697097] Lustre: Unmounted lustre-client [16146.551397] Key type lgssc unregistered [16147.062436] LNet: 315218:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16147.069633] LNetError: 315218:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16148.146678] LNet: Removed LNI 192.168.202.13@tcp [16149.441373] Key type .llcrypt unregistered [16149.443235] Key type ._llcrypt unregistered [16166.838590] Key type ._llcrypt registered [16166.847655] Key type .llcrypt registered [16168.621475] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 03:34:12 (1788852852) [16170.649393] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16170.846899] alg: No test for adler32 (adler32-zlib) [16172.200953] Lustre: Lustre: Build Version: 2.17.57_113_gf5ca795 [16172.510919] LNet: Added LNI 192.168.202.13@tcp [8/256/0/180] [16174.239255] Key type lgssc registered [16175.811307] Lustre: Echo OBD driver; http://www.lustre.org/ [16333.735226] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16340.425906] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16366.147597] Lustre: DEBUG MARKER: oleg213-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16487.860755] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16167 sec ========= 03:39:31 (1788853171) [16489.379710] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 03:39:34 (1788853174) === [16494.731750] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 03:39:38 (1788853178) === [16536.899504] Key type lgssc unregistered [16537.258186] LNet: 324487:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16537.279609] LNetError: 324487:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16537.301862] LNet: Removed LNI 192.168.202.13@tcp [16538.111568] Key type .llcrypt unregistered [16538.113426] Key type ._llcrypt unregistered