[ 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 483994343 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001009] APIC: Switch to symmetric I/O mode setup [ 0.002307] x2apic enabled [ 0.003010] Switched APIC routing to physical x2apic. [ 0.004020] kvm-guest: setup PV IPIs [ 0.006656] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009004] pid_max: default: 32768 minimum: 301 [ 0.010136] LSM: Security Framework initializing [ 0.012056] Yama: becoming mindful. [ 0.013045] SELinux: Initializing. [ 0.014084] *** VALIDATE selinux *** [ 0.022404] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027114] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029159] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030109] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032022] *** VALIDATE tmpfs *** [ 0.033474] *** VALIDATE proc *** [ 0.035156] *** VALIDATE cgroup *** [ 0.036011] *** VALIDATE cgroup2 *** [ 0.037282] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.039166] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.040043] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.041037] Spectre V2 : User space: Vulnerable [ 0.042012] Speculative Store Bypass: Vulnerable [ 0.045035] debug: unmapping init [mem 0xffffffffb3259000-0xffffffffb3260fff] [ 0.047201] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.048704] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.049026] ... version: 2 [ 0.050014] ... bit width: 48 [ 0.051012] ... generic registers: 4 [ 0.052010] ... value mask: 0000ffffffffffff [ 0.053014] ... max period: 00007fffffffffff [ 0.054015] ... fixed-purpose events: 3 [ 0.055010] ... event mask: 000000070000000f [ 0.056377] rcu: Hierarchical SRCU implementation. [ 0.058577] smp: Bringing up secondary CPUs ... [ 0.059599] x86: Booting SMP configuration: [ 0.060029] .... node #0, CPUs: #1 #2 #3 [ 0.063410] smp: Brought up 1 node, 4 CPUs [ 0.065013] smpboot: Max logical packages: 1 [ 0.066019] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.153883] node 0 deferred pages initialised in 84ms [ 0.157114] devtmpfs: initialized [ 0.159062] x86/mm: Memory block size: 128MB [ 0.161870] gcov: version magic: 0x41383552 [ 0.163166] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.164076] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.165267] pinctrl core: initialized pinctrl subsystem [ 0.166184] [ 0.166667] ************************************************************* [ 0.167017] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.168016] ** ** [ 0.169017] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.170013] ** ** [ 0.171019] ** This means that this kernel is built to expose internal ** [ 0.172029] ** IOMMU data structures, which may compromise security on ** [ 0.173013] ** your system. ** [ 0.174015] ** ** [ 0.175026] ** If you see this message and you are not debugging the ** [ 0.176028] ** kernel, report this immediately to your vendor! ** [ 0.177055] ** ** [ 0.178017] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.179019] ************************************************************* [ 0.180623] NET: Registered protocol family 16 [ 0.181470] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.182063] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.183066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.184468] cpuidle: using governor menu [ 0.185503] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.188537] PCI: Using configuration type 1 for base access [ 0.191269] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.201178] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.204026] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.207414] cryptd: max_cpu_qlen set to 1000 [ 0.211274] ACPI: Added _OSI(Module Device) [ 0.212016] ACPI: Added _OSI(Processor Device) [ 0.214012] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.216013] ACPI: Added _OSI(Processor Aggregator Device) [ 0.221122] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.227539] ACPI: Interpreter enabled [ 0.228057] ACPI: PM: (supports S0 S3 S4 S5) [ 0.229021] ACPI: Using IOAPIC for interrupt routing [ 0.230333] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.233340] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.243651] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.246045] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.248020] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.251075] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.256348] acpiphp: Slot [2] registered [ 0.258160] acpiphp: Slot [5] registered [ 0.259128] acpiphp: Slot [6] registered [ 0.261135] acpiphp: Slot [3] registered [ 0.262114] acpiphp: Slot [4] registered [ 0.264098] acpiphp: Slot [7] registered [ 0.265106] acpiphp: Slot [8] registered [ 0.266116] acpiphp: Slot [9] registered [ 0.268100] acpiphp: Slot [10] registered [ 0.269114] acpiphp: Slot [11] registered [ 0.271108] acpiphp: Slot [12] registered [ 0.272114] acpiphp: Slot [13] registered [ 0.274101] acpiphp: Slot [14] registered [ 0.275114] acpiphp: Slot [15] registered [ 0.277124] acpiphp: Slot [16] registered [ 0.278089] acpiphp: Slot [17] registered [ 0.279102] acpiphp: Slot [18] registered [ 0.281094] acpiphp: Slot [19] registered [ 0.282171] acpiphp: Slot [20] registered [ 0.284102] acpiphp: Slot [21] registered [ 0.285131] acpiphp: Slot [22] registered [ 0.287102] acpiphp: Slot [23] registered [ 0.288102] acpiphp: Slot [24] registered [ 0.290148] acpiphp: Slot [25] registered [ 0.291112] acpiphp: Slot [26] registered [ 0.293117] acpiphp: Slot [27] registered [ 0.294128] acpiphp: Slot [28] registered [ 0.295000] acpiphp: Slot [29] registered [ 0.295000] acpiphp: Slot [30] registered [ 0.297151] acpiphp: Slot [31] registered [ 0.299151] PCI host bridge to bus 0000:00 [ 0.300024] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.302023] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.304029] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.307027] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.309026] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.312032] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.314192] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.316991] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.320325] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.327594] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.332032] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.335017] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.337019] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.339015] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.341550] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.345502] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.348046] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.350965] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.356021] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.363751] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.368016] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.374036] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.380021] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.384014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.396018] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.404089] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.408020] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.412015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.430012] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.437113] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.438239] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.440250] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.443392] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.446306] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.451036] iommu: Default domain type: Passthrough [ 0.453466] SCSI subsystem initialized [ 0.455162] ACPI: bus type USB registered [ 0.456099] usbcore: registered new interface driver usbfs [ 0.458092] usbcore: registered new interface driver hub [ 0.461098] usbcore: registered new device driver usb [ 0.463157] pps_core: LinuxPPS API ver. 1 registered [ 0.465013] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.468063] PTP clock support registered [ 0.471106] EDAC MC: Ver: 3.0.0 [ 0.473114] PCI: Using ACPI for IRQ routing [ 0.474441] NetLabel: Initializing [ 0.475009] NetLabel: domain hash size = 128 [ 0.476006] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.477062] NetLabel: unlabeled traffic allowed by default [ 0.480038] vgaarb: loaded [ 0.481347] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.482009] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.487324] clocksource: Switched to clocksource kvm-clock [ 0.595968] VFS: Disk quotas dquot_6.6.0 [ 0.597459] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.600022] *** VALIDATE ramfs *** [ 0.601284] *** VALIDATE hugetlbfs *** [ 0.603484] pnp: PnP ACPI init [ 0.605856] pnp: PnP ACPI: found 6 devices [ 0.636645] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.639891] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.642087] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.644323] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.646892] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.649193] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.651910] NET: Registered protocol family 2 [ 0.654354] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.658256] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.661177] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.666956] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.670799] TCP: Hash tables configured (established 65536 bind 65536) [ 0.674114] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.677845] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.680864] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.684176] NET: Registered protocol family 1 [ 0.687074] RPC: Registered named UNIX socket transport module. [ 0.689254] RPC: Registered udp transport module. [ 0.690851] RPC: Registered tcp transport module. [ 0.692548] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.695140] NET: Registered protocol family 44 [ 0.696693] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.699078] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.701206] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.703398] PCI: CLS 0 bytes, default 64 [ 0.705194] Unpacking initramfs... [ 2.127562] debug: unmapping init [mem 0xffffa08cbcc64000-0xffffa08cbffcffff] [ 2.132899] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.135557] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.137905] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.599548] Initialise system trusted keyrings [ 2.601049] Key type blacklist registered [ 2.603614] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.614339] zbud: loaded [ 2.617728] *** VALIDATE nfs *** [ 2.619158] *** VALIDATE nfs4 *** [ 2.620901] pstore: using deflate compression [ 2.624814] Platform Keyring initialized [ 2.709314] NET: Registered protocol family 38 [ 2.711117] Key type asymmetric registered [ 2.712591] Asymmetric key parser 'x509' registered [ 2.714426] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.717484] io scheduler mq-deadline registered [ 2.718626] io scheduler kyber registered [ 2.720643] io scheduler bfq registered [ 2.722127] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.724143] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.725861] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.727760] ACPI: Power Button [PWRF] [ 2.732889] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.739033] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.749084] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.777942] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.805311] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.809257] Non-volatile memory driver v1.3 [ 2.810376] Linux agpgart interface v0.103 [ 2.837573] virtio_blk virtio1: [vda] 146136 512-byte logical blocks (74.8 MB/71.4 MiB) [ 2.840276] vda: detected capacity change from 0 to 74821632 [ 2.852982] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.855165] vdb: detected capacity change from 0 to 1073741824 [ 2.861482] libphy: Fixed MDIO Bus: probed [ 2.866839] usbcore: registered new interface driver usbserial_generic [ 2.869263] usbserial: USB Serial support registered for generic [ 2.871690] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.875941] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.877772] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.880098] mousedev: PS/2 mouse device common for all mice [ 2.882408] rtc_cmos 00:05: RTC can wake from S4 [ 2.887243] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.887556] rtc_cmos 00:05: registered as rtc0 [ 2.891400] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.894533] intel_pstate: CPU model not supported [ 2.897187] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.899263] hid: raw HID events driver (C) Jiri Kosina [ 2.902130] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.902143] usbcore: registered new interface driver usbhid [ 2.906322] usbhid: USB HID core driver [ 2.908051] drop_monitor: Initializing network drop monitor service [ 2.910637] Initializing XFRM netlink socket [ 2.912766] NET: Registered protocol family 10 [ 2.915891] Segment Routing with IPv6 [ 2.917127] NET: Registered protocol family 17 [ 2.919031] mpls_gso: MPLS GSO support [ 2.923408] RAS: Correctable Errors collector initialized. [ 2.924803] AVX version of gcm_enc/dec engaged. [ 2.926530] AES CTR mode by8 optimization enabled [ 2.982396] sched_clock: Marking stable (2982377696, 0)->(3868727763, -886350067) [ 2.984574] registered taskstats version 1 [ 2.986554] Loading compiled-in X.509 certificates [ 2.987830] zswap: loaded using pool lzo/zbud [ 3.008894] Key type big_key registered [ 3.018959] Key type encrypted registered [ 3.020024] ima: No TPM chip found, activating TPM-bypass! [ 3.021209] ima: Allocated hash algorithm: sha1 [ 3.022189] ima: No architecture policies found [ 3.023208] evm: Initialising EVM extended attributes: [ 3.024355] evm: security.selinux [ 3.024983] evm: security.ima [ 3.025611] evm: security.capability [ 3.026325] evm: HMAC attrs: 0x1 [ 3.028155] rtc_cmos 00:05: setting system clock to 2026-08-23 04:56:49 UTC (1787461009) [ 3.032135] debug: unmapping init [mem 0xffffffffb4203000-0xffffffffb43fffff] [ 3.034142] debug: unmapping init [mem 0xffffffffb2f82000-0xffffffffb3258fff] [ 3.041095] Write protecting the kernel read-only data: 28672k [ 3.043299] debug: unmapping init [mem 0xffffffffb1603000-0xffffffffb17fffff] [ 3.045133] debug: unmapping init [mem 0xffffffffb1f14000-0xffffffffb1ffffff] [ 3.070993] 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.077844] systemd[1]: Detected virtualization kvm. [ 3.079191] systemd[1]: Detected architecture x86-64. [ 3.080496] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.111132] systemd[1]: No hostname configured. [ 3.112186] systemd[1]: Set hostname to . [ 3.113425] random: systemd: uninitialized urandom read (16 bytes read) [ 3.115044] systemd[1]: Initializing machine ID from random generator. [ 3.169386] random: ln: uninitialized urandom read (6 bytes read) [ 3.241609] random: systemd: uninitialized urandom read (16 bytes read) [ 3.243347] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.247931] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 3.250144] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Timers. [ OK ] Reached target Slices. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Journal Service... [ OK ] Reached target Sockets. Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Starting Create Volatile Files and Directories... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.794693] device-mapper: uevent: version 1.0.3 [ 3.797103] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.448919] virtio_net virtio0 ens2: renamed from eth0 [ 4.455840] random: fast init done [ 4.510516] scsi host0: ata_piix [ 4.522299] scsi host1: ata_piix [ 4.523766] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.526018] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.248306] dracut-initqueue[588]: RTNETLINK answers: File exists [ 9.541334] random: crng init done [ 9.542786] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 9.923080] 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... 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 Timers. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev 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.153470] printk: systemd: 24 output lines suppressed due to ratelimiting [ 11.414850] SELinux: Disabled at runtime. [ 11.474545] 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.481104] systemd[1]: Detected virtualization kvm. [ 11.482643] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.970353] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.973188] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.978170] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.982722] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.986148] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.998531] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.007271] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Reached target rpc_pipefs.target. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Kernel Socket. Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. Activating swap /dev/disk/by-label/SWAP... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ 12.085537] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... Mounting Huge Pages File System... [ OK ] Listening on initctl Compatibility Named Pipe. Starting Apply Kernel Variables... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Mounting Kernel Debug File System... [ OK ] Created slice system-getty.slice. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Kernel Debug File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.517545] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.854180] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.878284] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.985226] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.995421] EDAC sbridge: Ver: 1.1.2 [ 14.291984] Key type dns_resolver registered [ 14.594537] NFS: Registering the id_resolver key type [ 14.596641] Key type id_resolver registered [ 14.597782] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. Starting Login Service... Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg202-client login: [ 59.603738] libcfs: loading out-of-tree module taints kernel. [ 59.700206] Key type ._llcrypt registered [ 59.702750] Key type .llcrypt registered [ 60.628550] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 60.651595] alg: No test for adler32 (adler32-zlib) [ 62.242829] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 63.194652] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 64.903434] Key type lgssc registered [ 67.096599] Lustre: Echo OBD driver; http://www.lustre.org/ [ 168.547028] hrtimer: interrupt took 5018717 ns [ 257.018624] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 262.277306] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 279.765273] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing check_logdir /tmp/testlogs/ [ 282.591149] Lustre: lustre-OST0000-osc-ffffa08d1003d000: disconnect after 24s idle [ 285.379045] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing yml_node [ 293.184547] Lustre: DEBUG MARKER: Client: 2.17.57.65 [ 296.704524] Lustre: DEBUG MARKER: MDS: 2.17.57.65 [ 300.233957] Lustre: DEBUG MARKER: OSS: 2.17.57.65 [ 302.554202] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sun Aug 23 01:01:47 EDT 2026 [ 323.999688] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 326.166397] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 328.833741] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 339.187231] Lustre: Unmounted lustre-client [ 477.245920] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 486.789679] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 514.222376] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 558.430921] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 01:06:03 (1787461563) [ 561.333216] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 563.235573] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 01:06:08 (1787461568) [ 603.630314] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 611.022365] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 637.237361] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 643.671129] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 649.001746] Lustre: Unmounted lustre-client [ 680.951866] Key type lgssc unregistered [ 681.291762] LNet: 15088:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 681.296906] LNetError: 15088:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 682.343610] LNet: Removed LNI 192.168.202.2@tcp [ 683.404598] Key type .llcrypt unregistered [ 683.408109] Key type ._llcrypt unregistered [ 708.465400] Key type ._llcrypt registered [ 708.466948] Key type .llcrypt registered [ 709.557502] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 01:08:34 (1787461714) [ 711.100988] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 711.254353] alg: No test for adler32 (adler32-zlib) [ 712.382843] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 712.631747] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 714.287506] Key type lgssc registered [ 716.050577] Lustre: Echo OBD driver; http://www.lustre.org/ [ 807.405778] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 899.511289] Lustre: Unmounted lustre-client [ 945.486429] Key type lgssc unregistered [ 945.754548] LNet: 18886:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 945.766738] LNetError: 18886:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 945.823039] LNet: Removed LNI 192.168.202.2@tcp [ 946.704240] Key type .llcrypt unregistered [ 946.709239] Key type ._llcrypt unregistered [ 961.088795] Key type ._llcrypt registered [ 961.091036] Key type .llcrypt registered [ 962.715219] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 01:12:47 (1787461967) [ 965.658843] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 965.691881] alg: No test for adler32 (adler32-zlib) [ 966.934506] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 967.343319] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 969.111882] Key type lgssc registered [ 970.582021] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1035.345619] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1042.081565] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1066.157787] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1073.238434] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 1086.105200] Lustre: Unmounted lustre-client [ 1124.884623] Key type lgssc unregistered [ 1125.132812] LNet: 22497:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1125.142291] LNetError: 22497:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1125.156756] LNet: Removed LNI 192.168.202.2@tcp [ 1125.916456] Key type .llcrypt unregistered [ 1125.918258] Key type ._llcrypt unregistered [ 1137.296456] Key type ._llcrypt registered [ 1137.302422] Key type .llcrypt registered [ 1138.613267] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 01:15:43 (1787462143) [ 1141.476624] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1141.578105] alg: No test for adler32 (adler32-zlib) [ 1142.703417] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 1143.026825] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 1144.791419] Key type lgssc registered [ 1146.625716] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1212.462782] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1220.526471] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1246.834488] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1252.934151] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 1260.483888] Lustre: Unmounted lustre-client [ 1293.290629] Key type lgssc unregistered [ 1293.579859] LNet: 25698:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1293.595830] LNetError: 25698:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1293.609174] LNet: Removed LNI 192.168.202.2@tcp [ 1294.291326] Key type .llcrypt unregistered [ 1294.295156] Key type ._llcrypt unregistered [ 1312.142782] Key type ._llcrypt registered [ 1312.147804] Key type .llcrypt registered [ 1313.650660] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 01:18:38 (1787462318) [ 1317.290473] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1317.308164] alg: No test for adler32 (adler32-zlib) [ 1318.427815] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 1318.678240] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 1320.375203] Key type lgssc registered [ 1322.104565] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1386.632942] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1394.010229] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1422.770421] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1425.724428] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 1431.031063] Lustre: lustre-MDT0000-mdc-ffffa08d05df7800: Connection to lustre-MDT0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1441.258155] Lustre: lustre-MDT0001-mdc-ffffa08d05df7800: Connection to lustre-MDT0001 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1450.167368] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1456.609072] Lustre: 26658:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787462447/real 1787462447] req@00000000705c28e2 x1874290094905344/t0(0) o400->MGC192.168.202.102@tcp@192.168.202.102@tcp:26/25 lens 224/224 e 0 to 1 dl 1787462463 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1456.625514] LustreError: MGC192.168.202.102@tcp: Connection to MGS (at 192.168.202.102@tcp) was lost; in progress operations using this service will fail [ 1460.566745] Lustre: Unmounted lustre-client [ 1491.821939] Key type lgssc unregistered [ 1492.190641] LNet: 29363:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1492.197859] LNetError: 29363:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1492.216494] LNet: Removed LNI 192.168.202.2@tcp [ 1493.087925] Key type .llcrypt unregistered [ 1493.091107] Key type ._llcrypt unregistered [ 1515.763828] Key type ._llcrypt registered [ 1515.765511] Key type .llcrypt registered [ 1517.381191] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 01:22:02 (1787462522) [ 1519.566249] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1519.582957] alg: No test for adler32 (adler32-zlib) [ 1520.731832] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 1521.076126] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 1522.783259] Key type lgssc registered [ 1524.578117] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1584.876888] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1593.245287] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1623.655362] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1629.822885] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 1639.913939] Lustre: lustre-OST0000-osc-ffffa08d0344b800: Connection to lustre-OST0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1644.059630] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1654.472635] Lustre: Unmounted lustre-client [ 1685.603364] Key type lgssc unregistered [ 1685.905702] LNet: 32981:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1685.915140] LNetError: 32981:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1685.936393] LNet: Removed LNI 192.168.202.2@tcp [ 1686.569966] Key type .llcrypt unregistered [ 1686.572130] Key type ._llcrypt unregistered [ 1705.833431] Key type ._llcrypt registered [ 1705.835738] Key type .llcrypt registered [ 1707.690791] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 01:25:12 (1787462712) [ 1710.874809] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1710.924743] alg: No test for adler32 (adler32-zlib) [ 1711.980794] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 1712.314620] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 1714.039851] Key type lgssc registered [ 1715.446531] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1779.304217] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1787.196752] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1813.680703] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1819.808813] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 1824.219863] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1828.205916] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1840.395334] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-23 1h27m24s [ 1843.213568] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1845.223681] Lustre: lustre-MDT0000-mdc-ffffa08d09ba9800: Connection to lustre-MDT0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1854.311824] LustreError: 36780:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffffa08d09ba9800: can't stat MDS #0: rc = -19 [ 1856.182959] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1866.657314] Lustre: 33945:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787462857/real 1787462857] req@0000000023740500 x1874290506998144/t0(0) o400->MGC192.168.202.102@tcp@192.168.202.102@tcp:26/25 lens 224/224 e 0 to 1 dl 1787462873 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1866.728122] LustreError: MGC192.168.202.102@tcp: Connection to MGS (at 192.168.202.102@tcp) was lost; in progress operations using this service will fail [ 1866.761276] Lustre: Evicted from MGS (at 192.168.202.102@tcp) after server handle changed from 0x4641cef8db5967b0 to 0x4641cef8db596b53 [ 1866.795514] Lustre: MGC192.168.202.102@tcp: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [ 1867.831200] LustreError: lustre-MDT0000-mdc-ffffa08d09ba9800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1867.858923] Lustre: lustre-MDT0000-mdc-ffffa08d09ba9800: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [ 1875.556335] Lustre: DEBUG MARKER: Wait for df (36780) ... [ 1878.197430] Lustre: DEBUG MARKER: done [ 1881.893933] Lustre: Unmounted lustre-client [ 1914.324516] Key type lgssc unregistered [ 1914.558581] LNet: 37802:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1914.565036] LNetError: 37802:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1914.588425] LNet: Removed LNI 192.168.202.2@tcp [ 1915.400313] Key type .llcrypt unregistered [ 1915.402987] Key type ._llcrypt unregistered [ 1958.027021] Key type ._llcrypt registered [ 1958.028374] Key type .llcrypt registered [ 1959.305695] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 01:29:24 (1787462964) [ 1962.202061] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1962.216982] alg: No test for adler32 (adler32-zlib) [ 1963.578287] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 1963.877803] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 1965.663269] Key type lgssc registered [ 1967.202364] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2026.960595] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2033.191196] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2055.776563] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2058.650526] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 2063.905197] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-23 1h31m08s [ 2065.764463] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 2075.814953] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 2079.352341] Lustre: DEBUG MARKER: Creating a test file and stat it [ 2099.680025] Lustre: 41960:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787463086/real 1787463086] req@0000000045fe5e4b x1874290771238016/t0(0) o101->lustre-MDT0000-mdc-ffffa08d06f62800@192.168.202.102@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787463106 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 2099.727829] Lustre: lustre-MDT0000-mdc-ffffa08d06f62800: Connection to lustre-MDT0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2099.775908] Lustre: lustre-MDT0000-mdc-ffffa08d06f62800: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [ 2121.603847] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 2125.856396] Lustre: DEBUG MARKER: done [ 2130.783146] Lustre: Unmounted lustre-client [ 2161.725648] Key type lgssc unregistered [ 2162.016358] LNet: 42840:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2162.038520] LNetError: 42840:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2163.110285] LNet: Removed LNI 192.168.202.2@tcp [ 2163.901873] Key type .llcrypt unregistered [ 2163.910194] Key type ._llcrypt unregistered [ 2207.103179] Key type ._llcrypt registered [ 2207.104887] Key type .llcrypt registered [ 2209.109957] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 01:33:33 (1787463213) [ 2210.768416] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2213.592469] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 01:33:37 (1787463217) [ 2219.929959] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2220.173870] alg: No test for adler32 (adler32-zlib) [ 2221.867992] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 2222.466611] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 2224.352152] Key type lgssc registered [ 2226.815376] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2269.021389] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 01:34:33 (1787463273) [ 2311.075670] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2318.437806] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2345.044762] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2346.775744] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 2350.280449] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2355.794189] Lustre: Unmounted lustre-client [ 2377.777168] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2448.525888] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2455.624943] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2456.301677] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 2461.336330] Lustre: Unmounted lustre-client [ 2531.821585] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2537.603651] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2538.427792] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 2542.976174] Lustre: Unmounted lustre-client [ 2569.779558] Lustre: DEBUG MARKER: files compared the same [ 2592.981558] Key type lgssc unregistered [ 2593.209819] LNet: 50497:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2593.215732] LNetError: 50497:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2594.292161] LNet: Removed LNI 192.168.202.2@tcp [ 2595.080304] Key type .llcrypt unregistered [ 2595.083098] Key type ._llcrypt unregistered [ 2613.231146] Key type ._llcrypt registered [ 2613.235306] Key type .llcrypt registered [ 2614.889587] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 01:40:19 (1787463619) [ 2617.483607] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2617.646015] alg: No test for adler32 (adler32-zlib) [ 2618.772040] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 2618.940732] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 2620.599201] Key type lgssc registered [ 2621.962423] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2684.277661] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2691.946731] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2718.171381] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2725.446519] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 2730.369175] Lustre: Unmounted lustre-client [ 2762.517729] Key type lgssc unregistered [ 2762.904602] LNet: 54088:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2762.911319] LNetError: 54088:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2762.936404] LNet: Removed LNI 192.168.202.2@tcp [ 2764.058086] Key type .llcrypt unregistered [ 2764.060401] Key type ._llcrypt unregistered [ 2782.008335] Key type ._llcrypt registered [ 2782.010014] Key type .llcrypt registered [ 2784.951397] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 01:43:08 (1787463788) [ 2789.927253] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2790.095427] alg: No test for adler32 (adler32-zlib) [ 2791.519652] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 2791.725235] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 2793.639494] Key type lgssc registered [ 2795.543826] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2889.711613] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2928.249618] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2935.104256] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2967.743544] Key type lgssc unregistered [ 2968.221254] LNet: 57582:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2968.236110] LNetError: 57582:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2968.249714] LNet: Removed LNI 192.168.202.2@tcp [ 2969.207263] Key type .llcrypt unregistered [ 2969.211129] Key type ._llcrypt unregistered [ 2987.350297] Key type ._llcrypt registered [ 2987.355639] Key type .llcrypt registered [ 2989.240550] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 01:46:33 (1787463993) [ 2995.085289] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2995.122153] alg: No test for adler32 (adler32-zlib) [ 2996.336356] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 2996.594701] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 2998.263274] Key type lgssc registered [ 3000.352897] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3099.685408] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 3107.178502] Lustre: Unmounted lustre-client [ 3150.480494] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 01:49:14 (1787464154) [ 3296.079393] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3320.405401] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 3328.323571] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3328.331588] LustreError: 64062:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffffa08d05f13000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3328.357825] Lustre: 58567:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.102@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3338.673608] Lustre: Unmounted lustre-client [ 3397.352474] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 01:53:22 (1787464402) [ 3411.850502] Key type lgssc unregistered [ 3412.128715] LNet: 65281:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3412.137706] LNetError: 65281:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3412.157414] LNet: Removed LNI 192.168.202.2@tcp [ 3412.822202] Key type .llcrypt unregistered [ 3412.823836] Key type ._llcrypt unregistered [ 3429.987326] Key type ._llcrypt registered [ 3429.989119] Key type .llcrypt registered [ 3430.262498] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3430.288043] alg: No test for adler32 (adler32-zlib) [ 3431.471813] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 3431.831865] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 3433.568163] Key type lgssc registered [ 3435.116553] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3501.162807] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3510.138954] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3536.277845] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3542.630953] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 3547.358796] Lustre: Unmounted lustre-client [ 3579.607953] Key type lgssc unregistered [ 3579.862763] LNet: 68305:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3579.888287] LNetError: 68305:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3579.915177] LNet: Removed LNI 192.168.202.2@tcp [ 3580.861583] Key type .llcrypt unregistered [ 3580.873276] Key type ._llcrypt unregistered [ 3593.965064] Key type ._llcrypt registered [ 3593.975512] Key type .llcrypt registered [ 3594.604981] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3594.642119] alg: No test for adler32 (adler32-zlib) [ 3595.877521] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 3596.148733] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 3597.879199] Key type lgssc registered [ 3599.975743] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3740.320734] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3748.922673] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3779.776912] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3782.792977] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 3786.568358] Lustre: Unmounted lustre-client [ 3821.487325] Key type lgssc unregistered [ 3821.904589] LNet: 71759:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3821.928661] LNetError: 71759:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3821.953916] LNet: Removed LNI 192.168.202.2@tcp [ 3823.383885] Key type .llcrypt unregistered [ 3823.388190] Key type ._llcrypt unregistered [ 3848.732143] Key type ._llcrypt registered [ 3848.735690] Key type .llcrypt registered [ 3850.372197] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 02:00:54 (1787464854) [ 3854.238568] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3854.302114] alg: No test for adler32 (adler32-zlib) [ 3855.772682] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 3856.283418] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 3858.119207] Key type lgssc registered [ 3859.629316] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3925.129580] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3932.318426] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3962.360910] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3965.350706] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 3972.702749] Lustre: Unmounted lustre-client [ 3973.381899] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 3977.153866] Lustre: Unmounted lustre-client [ 4009.871596] Key type lgssc unregistered [ 4010.421396] LNet: 75471:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4010.432095] LNetError: 75471:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4010.479903] LNet: Removed LNI 192.168.202.2@tcp [ 4011.805602] Key type .llcrypt unregistered [ 4011.810589] Key type ._llcrypt unregistered [ 4028.398930] Key type ._llcrypt registered [ 4028.402561] Key type .llcrypt registered [ 4029.090932] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4029.121654] alg: No test for adler32 (adler32-zlib) [ 4030.265824] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 4030.639088] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 4032.296126] Key type lgssc registered [ 4033.576082] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4098.276508] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4105.536784] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4131.461053] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4139.133081] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 4144.464238] Lustre: Unmounted lustre-client [ 4175.413220] Key type lgssc unregistered [ 4175.816947] LNet: 78512:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4175.825178] LNetError: 78512:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4175.856872] LNet: Removed LNI 192.168.202.2@tcp [ 4176.673693] Key type .llcrypt unregistered [ 4176.675773] Key type ._llcrypt unregistered [ 4207.991326] Key type ._llcrypt registered [ 4208.000418] Key type .llcrypt registered [ 4209.753041] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 02:06:53 (1787465213) [ 4213.633271] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4213.717274] alg: No test for adler32 (adler32-zlib) [ 4215.064601] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 4215.569703] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 4217.383454] Key type lgssc registered [ 4219.032729] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4284.339540] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4292.424750] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4322.199918] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4324.090558] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 4339.345922] Lustre: lustre: root_squash is set to 0:0 [ 4339.407375] Lustre: lustre: nosquash_nids is cleared [ 4346.752318] Lustre: lustre: root_squash is set to 500:500 [ 4356.552746] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.2@tcp 192.168.0.[2,10]@tcp [ 4365.419057] Lustre: lustre: nosquash_nids set to 192.168.202.2/24@tcp [ 4368.940440] Lustre: Unmounted lustre-client [ 4402.215981] Key type lgssc unregistered [ 4402.509943] LNet: 82457:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4402.520488] LNetError: 82457:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4402.544374] LNet: Removed LNI 192.168.202.2@tcp [ 4403.614760] Key type .llcrypt unregistered [ 4403.618209] Key type ._llcrypt unregistered [ 4422.312783] Key type ._llcrypt registered [ 4422.322471] Key type .llcrypt registered [ 4424.560476] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 02:10:28 (1787465428) [ 4428.487815] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 4430.531641] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 02:10:35 (1787465435) [ 4435.000640] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4435.088429] alg: No test for adler32 (adler32-zlib) [ 4436.382842] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 4436.817642] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 4438.543192] Key type lgssc registered [ 4440.617345] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4502.437716] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4509.047311] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4536.563781] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4538.556371] Lustre: lustre: root_squash is set to 500:500 [ 4538.590181] Lustre: lustre: nosquash_nids set to 192.168.202.2/24@tcp [ 4544.102920] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 4552.633341] Lustre: Unmounted lustre-client [ 4584.819237] Key type lgssc unregistered [ 4585.298713] LNet: 86428:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4585.309361] LNetError: 86428:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4586.349418] LNet: Removed LNI 192.168.202.2@tcp [ 4587.629711] Key type .llcrypt unregistered [ 4587.631216] Key type ._llcrypt unregistered [ 4607.584702] Key type ._llcrypt registered [ 4607.586394] Key type .llcrypt registered [ 4609.244721] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4612.587691] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 02:13:36 (1787465616) [ 4635.586856] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4635.637412] alg: No test for adler32 (adler32-zlib) [ 4637.000786] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 4637.390610] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 4639.115743] Key type lgssc registered [ 4641.112415] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4748.769415] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4755.535743] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4786.046420] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4871.717887] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4879.926441] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4908.710551] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4924.814511] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 4972.305247] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffffa08d08010800.ost_server_uuid 50 [ 4975.191692] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffffa08d08010800.ost_server_uuid in IDLE state after 0 sec [ 4976.128981] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 4981.532604] Lustre: Unmounted lustre-client [ 4984.892024] Lustre: Unmounted lustre-client [ 5044.657909] Key type lgssc unregistered [ 5045.009787] LNet: 94115:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5045.017075] LNetError: 94115:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5045.047713] LNet: Removed LNI 192.168.202.2@tcp [ 5045.786586] Key type .llcrypt unregistered [ 5045.788754] Key type ._llcrypt unregistered [ 5089.502267] Key type ._llcrypt registered [ 5089.503441] Key type .llcrypt registered [ 5090.980404] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 02:21:35 (1787466095) [ 5116.928809] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5116.966821] alg: No test for adler32 (adler32-zlib) [ 5118.210698] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 5118.648167] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 5120.399358] Key type lgssc registered [ 5121.981301] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5239.279109] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5246.524537] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5277.767815] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5280.796471] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 5302.241638] Lustre: 95483:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787466292/real 1787466292] req@000000001494da09 x1874294079493376/t0(0) o400->lustre-OST0000-osc-ffffa08d1003a000@192.168.202.102@tcp:28/4 lens 224/224 e 0 to 1 dl 1787466308 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5302.276317] Lustre: lustre-OST0000-osc-ffffa08d1003a000: Connection to lustre-OST0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5307.938912] Lustre: 95482:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787466297/real 1787466297] req@000000002f78d11e x1874294079493888/t0(0) o400->lustre-OST0000-osc-ffffa08d1003a000@192.168.202.102@tcp:28/4 lens 224/224 e 0 to 1 dl 1787466313 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5312.480025] Lustre: 95483:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787466302/real 1787466302] req@000000001b55a53a x1874294079494400/t0(0) o400->lustre-OST0000-osc-ffffa08d1003a000@192.168.202.102@tcp:28/4 lens 224/224 e 0 to 1 dl 1787466318 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5315.185864] Lustre: lustre-OST0000-osc-ffffa08d1003a000: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [ 5317.280168] Lustre: 95482:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787466307/real 1787466307] req@00000000bd45c8e9 x1874294079494912/t0(0) o400->lustre-OST0000-osc-ffffa08d1003a000@192.168.202.102@tcp:28/4 lens 224/224 e 0 to 1 dl 1787466323 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5322.736398] Lustre: lustre-MDT0000-mdc-ffffa08d1003a000: Connection to lustre-MDT0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5339.103799] Lustre: 95483:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787466329/real 1787466329] req@000000005b9bf7bd x1874294079497728/t0(0) o400->MGC192.168.202.102@tcp@192.168.202.102@tcp:26/25 lens 224/224 e 0 to 1 dl 1787466345 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5339.157499] LustreError: MGC192.168.202.102@tcp: Connection to MGS (at 192.168.202.102@tcp) was lost; in progress operations using this service will fail [ 5350.389854] Lustre: Evicted from MGS (at 192.168.202.102@tcp) after server handle changed from 0x5412d5fd6956b992 to 0x5412d5fd6956bb28 [ 5350.403228] Lustre: MGC192.168.202.102@tcp: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [ 5359.059811] Lustre: lustre-MDT0000-mdc-ffffa08d1003a000: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [ 5365.847466] Lustre: Unmounted lustre-client [ 5409.589901] Key type lgssc unregistered [ 5409.936033] LNet: 99806:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5409.940947] LNetError: 99806:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5409.960661] LNet: Removed LNI 192.168.202.2@tcp [ 5410.830552] Key type .llcrypt unregistered [ 5410.836518] Key type ._llcrypt unregistered [ 5434.190247] Key type ._llcrypt registered [ 5434.192861] Key type .llcrypt registered [ 5436.212116] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 02:27:20 (1787466440) [ 5454.155506] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5454.444781] alg: No test for adler32 (adler32-zlib) [ 5455.756772] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 5456.181055] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 5457.863219] Key type lgssc registered [ 5459.611978] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5510.414320] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5650.280270] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5658.701545] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5690.983154] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5693.289940] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 5697.467485] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5700.443850] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 02:31:44 (1787466704) [ 5980.486222] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5990.857875] Lustre: Unmounted lustre-client [ 6145.538562] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6152.462864] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6181.708744] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6234.536806] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 02:40:39 (1787467239) [ 6365.518918] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6373.374453] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6405.879542] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6406.833508] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 6414.380559] Lustre: Unmounted lustre-client [ 6456.012916] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 02:44:20 (1787467460) [ 6582.986273] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6590.747624] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6623.200155] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6624.343447] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 6630.184239] Lustre: Unmounted lustre-client [ 6664.413915] Key type lgssc unregistered [ 6664.862908] LNet: 122872:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6664.878363] LNetError: 122872:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6664.907639] LNet: Removed LNI 192.168.202.2@tcp [ 6666.527590] Key type .llcrypt unregistered [ 6666.531261] Key type ._llcrypt unregistered [ 6690.844118] Key type ._llcrypt registered [ 6690.845718] Key type .llcrypt registered [ 6692.642132] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 02:48:17 (1787467697) [ 6695.813176] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6695.845088] alg: No test for adler32 (adler32-zlib) [ 6697.091683] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 6697.455796] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 6699.216792] Key type lgssc registered [ 6701.469608] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6779.203427] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6788.160536] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6817.254245] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6820.267434] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 6833.671958] Lustre: Unmounted lustre-client [ 6870.865213] Key type lgssc unregistered [ 6871.254570] LNet: 126475:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6871.265240] LNetError: 126475:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6871.300518] LNet: Removed LNI 192.168.202.2@tcp [ 6872.213517] Key type .llcrypt unregistered [ 6872.239860] Key type ._llcrypt unregistered [ 6899.674358] Key type ._llcrypt registered [ 6899.685916] Key type .llcrypt registered [ 6902.028325] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 02:51:45 (1787467905) [ 6906.085019] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6906.097544] alg: No test for adler32 (adler32-zlib) [ 6907.554673] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 6907.994988] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 6909.759260] Key type lgssc registered [ 6911.893721] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6989.798960] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6998.208910] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7028.912582] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7031.843605] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 7042.037683] Lustre: lustre-OST0000-osc-ffffa08d04e7b000: Connection to lustre-OST0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7056.928732] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffffa08d04e7b000.ost_server_uuid 50 [ 7059.311418] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 7071.539948] Lustre: Unmounted lustre-client [ 7095.018624] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 02:55:00 (1787468100) [ 7140.224934] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7148.403955] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7177.181906] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7208.307827] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7209.368158] LustreError: 127436:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 7209.513147] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 7214.584636] Lustre: lustre-OST0000-osc-ffffa08d08012000: Connection to lustre-OST0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7251.632561] Lustre: Unmounted lustre-client [ 7308.030361] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 02:58:32 (1787468312) [ 7350.265371] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7358.151890] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7384.196644] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7413.817437] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7414.913776] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 7419.912118] Lustre: lustre-OST0000-osc-ffffa08d09bae000: Connection to lustre-OST0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7446.504084] Lustre: Unmounted lustre-client [ 7503.970934] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 03:01:48 (1787468508) [ 7636.330298] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7645.049839] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7675.622911] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7768.931708] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7777.616405] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7805.493415] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7842.464197] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 7895.365709] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7897.647625] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7900.353607] Lustre: Unmounted lustre-client [ 7944.697244] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 03:09:09 (1787468949) [ 7995.198984] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8003.137433] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8030.376994] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8084.969985] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8127.174148] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 8180.103952] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8183.015522] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8200.138764] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8210.541737] Lustre: Unmounted lustre-client [ 8285.207130] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 03:14:49 (1787469289) [ 8328.727481] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8337.102495] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8367.926589] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8368.964939] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 8398.206415] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8400.012809] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8419.460636] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffffa08d09bad800.ost_server_uuid 50 [ 8423.046334] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffffa08d09bad800.ost_server_uuid in IDLE state after 0 sec [ 8430.180552] Lustre: Unmounted lustre-client [ 8430.678943] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 8430.700589] Lustre: Skipped 3 previous similar messages [ 8430.858341] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 8432.814288] LustreError: 149958:0:(sec.c:403:import_sec_validate_get()) import 00000000d788a14d (NEW) with no sec [ 8508.795301] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 03:18:33 (1787469513) [ 8552.081564] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8559.006692] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8585.503945] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8616.749183] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8617.465385] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 8617.734132] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 8632.471888] Lustre: Unmounted lustre-client [ 8632.475520] Lustre: Skipped 1 previous similar message [ 8675.188546] Key type lgssc unregistered [ 8675.406832] LNet: 153380:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8675.420668] LNetError: 153380:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8675.439573] LNet: Removed LNI 192.168.202.2@tcp [ 8676.292249] Key type .llcrypt unregistered [ 8676.294533] Key type ._llcrypt unregistered [ 8696.306428] Key type ._llcrypt registered [ 8696.308462] Key type .llcrypt registered [ 8697.644906] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 03:21:42 (1787469702) [ 8698.994110] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8699.013524] alg: No test for adler32 (adler32-zlib) [ 8700.130512] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 8700.451116] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 8702.129068] Key type lgssc registered [ 8703.641619] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8768.107061] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8775.224080] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8804.089504] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8830.978589] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8831.774927] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 8833.054260] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 8837.735221] LustreError: lustre-MDT0001-mdc-ffffa08d03f36000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 8837.754394] Lustre: lustre-MDT0001-mdc-ffffa08d03f36000: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [ 8844.620431] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8846.457301] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8869.919800] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 8875.493219] Lustre: Unmounted lustre-client [ 8910.439762] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 03:25:14 (1787469914) [ 9025.790543] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9033.856444] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9063.041442] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9063.830759] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 9093.972736] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9096.218962] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 9109.086764] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9119.496291] Lustre: Unmounted lustre-client [ 9156.250668] Key type lgssc unregistered [ 9156.500970] LNet: 162991:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9156.518151] LNetError: 162991:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9156.537775] LNet: Removed LNI 192.168.202.2@tcp [ 9157.455893] Key type .llcrypt unregistered [ 9157.459468] Key type ._llcrypt unregistered [ 9192.712518] Key type ._llcrypt registered [ 9192.713993] Key type .llcrypt registered [ 9194.093720] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 03:29:59 (1787470199) [ 9197.202322] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9197.357282] alg: No test for adler32 (adler32-zlib) [ 9198.422594] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 9198.654601] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 9200.353119] Key type lgssc registered [ 9202.327337] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9259.006936] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9266.444835] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9292.943130] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9295.051812] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 9344.131829] Lustre: Unmounted lustre-client [ 9392.107983] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9392.862137] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 9430.043249] Lustre: Unmounted lustre-client [ 9463.951488] Key type lgssc unregistered [ 9464.281976] LNet: 167439:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9464.289233] LNetError: 167439:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9464.325922] LNet: Removed LNI 192.168.202.2@tcp [ 9465.096725] Key type .llcrypt unregistered [ 9465.098701] Key type ._llcrypt unregistered [ 9482.302309] Key type ._llcrypt registered [ 9482.306612] Key type .llcrypt registered [ 9483.536517] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 03:34:48 (1787470488) [ 9486.409606] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9486.460354] alg: No test for adler32 (adler32-zlib) [ 9487.571631] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 9487.806516] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 9489.479754] Key type lgssc registered [ 9490.966556] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9549.017282] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9556.352992] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9582.117301] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9583.852032] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 9604.676242] Lustre: Unmounted lustre-client [ 9635.550626] Key type lgssc unregistered [ 9635.947504] LNet: 171196:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9635.962963] LNetError: 171196:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9635.993589] LNet: Removed LNI 192.168.202.2@tcp [ 9637.096405] Key type .llcrypt unregistered [ 9637.104453] Key type ._llcrypt unregistered [ 9653.646910] Key type ._llcrypt registered [ 9653.662156] Key type .llcrypt registered [ 9654.260514] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9654.310203] alg: No test for adler32 (adler32-zlib) [ 9655.817357] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 9656.088106] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 9657.775495] Key type lgssc registered [ 9659.911201] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9725.223730] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9733.071115] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9759.325378] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9765.506041] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 9772.923249] Lustre: Unmounted lustre-client [ 9803.603491] Key type lgssc unregistered [ 9803.988884] LNet: 174263:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9803.997361] LNetError: 174263:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9804.020220] LNet: Removed LNI 192.168.202.2@tcp [ 9804.662141] Key type .llcrypt unregistered [ 9804.665633] Key type ._llcrypt unregistered [ 9822.554712] Key type ._llcrypt registered [ 9822.557620] Key type .llcrypt registered [ 9824.548453] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 03:40:28 (1787470828) [ 9827.660171] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9827.701483] alg: No test for adler32 (adler32-zlib) [ 9828.912367] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [ 9829.219383] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [ 9830.951203] Key type lgssc registered [ 9832.365277] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9894.968459] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9902.056382] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9930.091668] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9935.935399] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [ 9961.554104] Lustre: Unmounted lustre-client [ 9993.670736] Key type lgssc unregistered [ 9994.027976] LNet: 178028:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9994.031126] LNetError: 178028:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9994.066188] LNet: Removed LNI 192.168.202.2@tcp [ 9994.928930] Key type .llcrypt unregistered [ 9994.940380] Key type ._llcrypt unregistered [10012.579601] Key type ._llcrypt registered [10012.583846] Key type .llcrypt registered [10013.278027] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10013.293258] alg: No test for adler32 (adler32-zlib) [10014.563113] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [10014.860428] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [10016.607448] Key type lgssc registered [10017.852393] Lustre: Echo OBD driver; http://www.lustre.org/ [10079.343863] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10087.739252] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10117.240903] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10119.212900] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [10127.363044] Lustre: Unmounted lustre-client [10159.691730] Key type lgssc unregistered [10159.918715] LNet: 181098:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10159.924818] LNetError: 181098:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10159.986524] LNet: Removed LNI 192.168.202.2@tcp [10160.960148] Key type .llcrypt unregistered [10160.963543] Key type ._llcrypt unregistered [10183.103973] Key type ._llcrypt registered [10183.105740] Key type .llcrypt registered [10184.514432] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 03:46:29 (1787471189) [10212.498898] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10212.863822] alg: No test for adler32 (adler32-zlib) [10214.027760] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [10214.275269] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [10215.967516] Key type lgssc registered [10217.381570] Lustre: Echo OBD driver; http://www.lustre.org/ [10316.800780] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10324.449638] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10351.373702] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10400.200205] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 03:50:05 (1787471405) [10441.248215] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10446.892090] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10473.581649] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10480.738050] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [10487.210438] Lustre: Unmounted lustre-client [10519.995571] Key type lgssc unregistered [10520.328946] LNet: 188207:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10520.333727] LNetError: 188207:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10520.351077] LNet: Removed LNI 192.168.202.2@tcp [10521.165595] Key type .llcrypt unregistered [10521.167757] Key type ._llcrypt unregistered [10541.325744] Key type ._llcrypt registered [10541.329836] Key type .llcrypt registered [10542.913164] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [10544.699289] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 03:52:29 (1787471549) [10567.650209] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10567.752066] alg: No test for adler32 (adler32-zlib) [10568.867934] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [10569.211801] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [10570.895250] Key type lgssc registered [10572.803381] Lustre: Echo OBD driver; http://www.lustre.org/ [10687.988897] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10694.737383] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10723.888293] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10752.675520] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10754.626402] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [10786.681076] Lustre: Unmounted lustre-client [10923.390685] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10928.830393] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10954.148145] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10998.332592] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 04:00:03 (1787472003) [11000.632525] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [11002.819806] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 04:00:07 (1787472007) [11123.026132] Key type lgssc unregistered [11123.437967] LNet: 199671:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11123.467077] LNetError: 199671:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11123.497664] LNet: Removed LNI 192.168.202.2@tcp [11124.560955] Key type .llcrypt unregistered [11124.562563] Key type ._llcrypt unregistered [11147.067742] Key type ._llcrypt registered [11147.073370] Key type .llcrypt registered [11148.858635] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 04:02:33 (1787472153) [11198.225301] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11198.249938] alg: No test for adler32 (adler32-zlib) [11199.522370] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [11199.758257] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [11201.464044] Key type lgssc registered [11203.006534] Lustre: Echo OBD driver; http://www.lustre.org/ [11259.682536] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11266.341665] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11304.742819] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11336.928718] Key type lgssc unregistered [11337.439241] LNet: 203410:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11337.453564] LNetError: 203410:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11337.483930] LNet: Removed LNI 192.168.202.2@tcp [11338.779405] Key type .llcrypt unregistered [11338.782556] Key type ._llcrypt unregistered [11356.707493] Key type ._llcrypt registered [11356.708913] Key type .llcrypt registered [11358.118182] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 04:06:03 (1787472363) [11360.899716] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11360.951898] alg: No test for adler32 (adler32-zlib) [11361.990183] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [11362.255110] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [11363.911385] Key type lgssc registered [11365.039946] Lustre: Echo OBD driver; http://www.lustre.org/ [11424.620468] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11432.482701] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11462.353310] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11468.351501] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [11478.517308] Lustre: lustre-MDT0000-mdc-ffffa08d03f39000: Connection to lustre-MDT0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [11488.775613] Lustre: lustre-MDT0001-mdc-ffffa08d03f39000: Connection to lustre-MDT0001 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [11499.808074] Lustre: 204413:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787472490/real 1787472490] req@000000000a00d06b x1874300625830016/t0(0) o400->MGC192.168.202.102@tcp@192.168.202.102@tcp:26/25 lens 224/224 e 0 to 1 dl 1787472506 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11499.851492] LustreError: MGC192.168.202.102@tcp: Connection to MGS (at 192.168.202.102@tcp) was lost; in progress operations using this service will fail [11525.441137] Lustre: Evicted from MGS (at 192.168.202.102@tcp) after server handle changed from 0x4cce5a9b045796e7 to 0x4cce5a9b0457b207 [11525.454532] Lustre: MGC192.168.202.102@tcp: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [11532.789244] Lustre: 206539:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.202.102@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [11559.414250] LustreError: lustre-MDT0000-mdc-ffffa08d03f39000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [11559.501416] Lustre: lustre-MDT0000-mdc-ffffa08d03f39000: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [11564.556650] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11565.809305] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11572.632443] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11574.938208] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [11580.430197] Lustre: Unmounted lustre-client [11612.665310] Key type lgssc unregistered [11613.086074] LNet: 208377:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11613.092047] LNetError: 208377:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11613.112915] LNet: Removed LNI 192.168.202.2@tcp [11614.275873] Key type .llcrypt unregistered [11614.279167] Key type ._llcrypt unregistered [11632.998538] Key type ._llcrypt registered [11633.001149] Key type .llcrypt registered [11634.387186] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 04:10:39 (1787472639) [11638.198281] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11638.226943] alg: No test for adler32 (adler32-zlib) [11639.587604] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [11639.850395] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [11641.607390] Key type lgssc registered [11642.978465] Lustre: Echo OBD driver; http://www.lustre.org/ [11700.850062] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11707.370177] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11777.678748] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11784.788668] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11829.031224] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11861.971985] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11924.193822] Key type lgssc unregistered [11924.472125] LNet: 213686:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11924.480738] LNetError: 213686:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11924.495800] LNet: Removed LNI 192.168.202.2@tcp [11925.398330] Key type .llcrypt unregistered [11925.399884] Key type ._llcrypt unregistered [11974.144692] Key type ._llcrypt registered [11974.146911] Key type .llcrypt registered [11975.779927] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 04:16:20 (1787472980) [12019.923845] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12019.932642] alg: No test for adler32 (adler32-zlib) [12020.986317] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [12021.165500] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [12022.879189] Key type lgssc registered [12024.592659] Lustre: Echo OBD driver; http://www.lustre.org/ [12124.502035] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12132.355891] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12160.084759] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12206.579523] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 04:20:11 (1787473211) [12217.156897] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 04:20:21 (1787473221) [12266.841355] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12274.667029] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12303.417739] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12305.403461] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [12311.562838] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [12313.717406] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [12315.577312] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [12317.627671] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [12320.754048] Lustre: lustre-MDT0000-mdc-ffffa08d03f3b000: Connection to lustre-MDT0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [12337.121869] Lustre: 215583:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787473327/real 1787473327] req@00000000a4ad8b41 x1874301316769408/t0(0) o400->MGC192.168.202.102@tcp@192.168.202.102@tcp:26/25 lens 224/224 e 0 to 1 dl 1787473343 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [12337.172750] LustreError: MGC192.168.202.102@tcp: Connection to MGS (at 192.168.202.102@tcp) was lost; in progress operations using this service will fail [12347.394449] Lustre: Evicted from MGS (at 192.168.202.102@tcp) after server handle changed from 0x32a27dbffb26af3f to 0x32a27dbffb26b0b2 [12347.419146] Lustre: MGC192.168.202.102@tcp: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [12354.503163] Lustre: lustre-MDT0000-mdc-ffffa08d03f3b000: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [12366.478817] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12368.575510] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [12373.251952] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [12378.093096] Lustre: lustre-MDT0000-mdc-ffffa08d03f3b000: Connection to lustre-MDT0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [12394.335733] Lustre: 215586:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787473384/real 1787473384] req@000000007fd7c7ae x1874301316779264/t0(0) o400->MGC192.168.202.102@tcp@192.168.202.102@tcp:26/25 lens 224/224 e 0 to 1 dl 1787473400 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [12394.383994] LustreError: MGC192.168.202.102@tcp: Connection to MGS (at 192.168.202.102@tcp) was lost; in progress operations using this service will fail [12403.699293] Lustre: Evicted from MGS (at 192.168.202.102@tcp) after server handle changed from 0x32a27dbffb26b0b2 to 0x32a27dbffb26b3c9 [12403.717675] Lustre: MGC192.168.202.102@tcp: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [12412.368395] Lustre: lustre-MDT0000-mdc-ffffa08d03f3b000: Connection restored to 192.168.202.102@tcp (at 192.168.202.102@tcp) [12426.063384] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12428.554237] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [12431.983539] Lustre: Unmounted lustre-client [12513.935739] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12521.532661] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12549.264615] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12555.360779] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [12558.044947] Lustre: Unmounted lustre-client [12587.873899] Key type lgssc unregistered [12588.091483] LNet: 226180:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12588.108203] LNetError: 226180:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12588.133358] LNet: Removed LNI 192.168.202.2@tcp [12588.848397] Key type .llcrypt unregistered [12588.850914] Key type ._llcrypt unregistered [12609.299080] Key type ._llcrypt registered [12609.310817] Key type .llcrypt registered [12611.146641] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 04:26:55 (1787473615) [12616.849969] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12616.926558] alg: No test for adler32 (adler32-zlib) [12618.290557] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [12618.562271] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [12620.288246] Key type lgssc registered [12621.890624] Lustre: Echo OBD driver; http://www.lustre.org/ [12683.817742] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12689.801341] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12711.391446] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12722.707891] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [12728.084142] Lustre: Unmounted lustre-client [12805.654206] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12813.262585] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12838.475625] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12849.765606] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [12860.921591] Lustre: Unmounted lustre-client [12943.976848] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12951.177560] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12975.799809] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12981.835437] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [12983.889404] Lustre: Unmounted lustre-client [13012.102764] Key type lgssc unregistered [13012.354906] LNet: 233245:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13012.360643] LNetError: 233245:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13012.389229] LNet: Removed LNI 192.168.202.2@tcp [13013.188412] Key type .llcrypt unregistered [13013.194106] Key type ._llcrypt unregistered [13031.890924] Key type ._llcrypt registered [13031.892772] Key type .llcrypt registered [13033.384838] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 04:33:58 (1787474038) [13037.875881] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13037.922988] alg: No test for adler32 (adler32-zlib) [13039.149597] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [13039.470531] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [13041.159242] Key type lgssc registered [13042.437274] Lustre: Echo OBD driver; http://www.lustre.org/ [13094.519586] Key type lgssc unregistered [13095.004465] LNet: 235571:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13095.018047] LNetError: 235571:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13095.043756] LNet: Removed LNI 192.168.202.2@tcp [13096.075988] Key type .llcrypt unregistered [13096.079990] Key type ._llcrypt unregistered [13129.195391] Key type ._llcrypt registered [13129.201931] Key type .llcrypt registered [13129.723269] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13129.736933] alg: No test for adler32 (adler32-zlib) [13131.059356] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [13131.451627] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [13133.335409] Key type lgssc registered [13134.875658] Lustre: Echo OBD driver; http://www.lustre.org/ [13230.837782] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13237.489225] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13263.561586] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13310.104405] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [13312.662922] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 04:38:36 (1787474316) [13353.151800] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13361.510618] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13389.260050] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13418.466864] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13421.295931] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [13426.685259] Lustre: lustre-OST0001-osc-ffffa08d04038000: Connection to lustre-OST0001 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [13434.135335] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13444.512821] Lustre: Unmounted lustre-client [13482.258063] Key type lgssc unregistered [13482.605312] LNet: 242693:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13482.620703] LNetError: 242693:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13482.647902] LNet: Removed LNI 192.168.202.2@tcp [13483.355441] Key type .llcrypt unregistered [13483.358317] Key type ._llcrypt unregistered [13521.967153] Key type ._llcrypt registered [13521.973648] Key type .llcrypt registered [13523.529175] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 04:42:08 (1787474528) [13539.213082] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13539.284513] alg: No test for adler32 (adler32-zlib) [13540.418127] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [13540.761448] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [13542.551205] Key type lgssc registered [13543.601337] Lustre: Echo OBD driver; http://www.lustre.org/ [13600.745331] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13609.338839] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13635.442320] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 04:44:00 (1787474640) [13676.029466] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13684.106031] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13710.793715] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13714.088800] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [13727.252427] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [13735.026427] Lustre: Unmounted lustre-client [13851.549536] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13858.889744] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13913.057630] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13913.995872] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [13916.644510] Lustre: Unmounted lustre-client [13947.883461] Key type lgssc unregistered [13948.135672] LNet: 250394:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13948.140474] LNetError: 250394:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13948.165270] LNet: Removed LNI 192.168.202.2@tcp [13948.930614] Key type .llcrypt unregistered [13948.932328] Key type ._llcrypt unregistered [13983.207906] Key type ._llcrypt registered [13983.222265] Key type .llcrypt registered [13983.705557] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13983.720736] alg: No test for adler32 (adler32-zlib) [13984.868977] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [13985.045742] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [13986.727526] Key type lgssc registered [13988.770470] Lustre: Echo OBD driver; http://www.lustre.org/ [14090.083188] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14099.392667] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14129.527872] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14183.657380] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [14187.457683] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 04:53:10 (1787475190) [14235.977580] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14244.374428] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14268.597314] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14273.601841] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [14277.526289] Lustre: Unmounted lustre-client [14318.813861] Key type lgssc unregistered [14319.108745] LNet: 257052:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14319.123913] LNetError: 257052:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14319.177315] LNet: Removed LNI 192.168.202.2@tcp [14320.410959] Key type .llcrypt unregistered [14320.422122] Key type ._llcrypt unregistered [14342.485149] Key type ._llcrypt registered [14342.486757] Key type .llcrypt registered [14343.956745] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [14346.125777] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 04:55:50 (1787475350) [14357.897646] Key type .llcrypt unregistered [14357.905320] Key type ._llcrypt unregistered [14368.349034] Key type ._llcrypt registered [14368.355556] Key type .llcrypt registered [14368.912824] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14368.925481] alg: No test for adler32 (adler32-zlib) [14370.102932] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [14370.684460] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [14372.511458] Key type lgssc registered [14373.807977] Lustre: Echo OBD driver; http://www.lustre.org/ [14433.616395] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14456.608492] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [14459.665051] Lustre: Unmounted lustre-client [14490.145456] Key type lgssc unregistered [14490.509331] LNet: 260516:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14490.518932] LNetError: 260516:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14490.551511] LNet: Removed LNI 192.168.202.2@tcp [14491.309180] Key type .llcrypt unregistered [14491.311577] Key type ._llcrypt unregistered [14511.442931] Key type ._llcrypt registered [14511.448658] Key type .llcrypt registered [14513.340234] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 04:58:37 (1787475517) [14516.372979] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14516.504354] alg: No test for adler32 (adler32-zlib) [14517.650377] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [14517.976854] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [14519.672867] Key type lgssc registered [14521.219827] Lustre: Echo OBD driver; http://www.lustre.org/ [14611.491582] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14649.152994] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14655.553273] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14657.583493] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [14661.345535] Lustre: Unmounted lustre-client [14687.674681] Key type lgssc unregistered [14688.240946] LNet: 264072:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14688.244506] LNetError: 264072:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14688.288346] LNet: Removed LNI 192.168.202.2@tcp [14689.405198] Key type .llcrypt unregistered [14689.407526] Key type ._llcrypt unregistered [14714.408287] Key type ._llcrypt registered [14714.420356] Key type .llcrypt registered [14715.941809] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 05:02:00 (1787475720) [14717.975661] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14718.300512] alg: No test for adler32 (adler32-zlib) [14719.405718] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [14719.647420] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [14721.352074] Key type lgssc registered [14724.424752] Lustre: Echo OBD driver; http://www.lustre.org/ [14778.659721] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14785.153415] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14807.031375] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14808.738822] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [14814.188550] Lustre: lustre-MDT0000-mdc-ffffa08d02e99000: Connection to lustre-MDT0000 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [14815.453430] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [14815.480062] LustreError: 267246:0:(file.c:6166:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [14815.849318] LustreError: MGC192.168.202.102@tcp: Connection to MGS (at 192.168.202.102@tcp) was lost; in progress operations using this service will fail [14815.895264] Lustre: Unmounted lustre-client [14838.402902] Key type lgssc unregistered [14838.696052] LNet: 267662:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14838.707537] LNetError: 267662:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14838.728751] LNet: Removed LNI 192.168.202.2@tcp [14839.509852] Key type .llcrypt unregistered [14839.512117] Key type ._llcrypt unregistered [14857.536684] Key type ._llcrypt registered [14857.538406] Key type .llcrypt registered [14859.139635] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 05:04:23 (1787475863) [14861.773978] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14861.785510] alg: No test for adler32 (adler32-zlib) [14862.796668] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [14862.982424] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [14864.639505] Key type lgssc registered [14865.942804] Lustre: Echo OBD driver; http://www.lustre.org/ [14927.131474] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14933.462458] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14955.752028] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14958.512665] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [14963.693924] Lustre: lustre-MDT0001-mdc-ffffa08d02f9b800: Connection to lustre-MDT0001 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [14970.249104] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [14972.650450] Lustre: Unmounted lustre-client [14997.668896] Key type lgssc unregistered [14997.972654] LNet: 271251:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14997.982661] LNetError: 271251:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14998.025785] LNet: Removed LNI 192.168.202.2@tcp [14998.633515] Key type .llcrypt unregistered [14998.637076] Key type ._llcrypt unregistered [15017.189358] Key type ._llcrypt registered [15017.191220] Key type .llcrypt registered [15018.698763] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 05:07:03 (1787476023) [15037.362380] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15037.544108] alg: No test for adler32 (adler32-zlib) [15038.789685] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [15039.023875] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [15040.671250] Key type lgssc registered [15042.083360] Lustre: Echo OBD driver; http://www.lustre.org/ [15176.260691] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15179.105457] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [15225.317199] Lustre: lustre-MDT0001-mdc-ffffa08d02e9f800: Connection to lustre-MDT0001 (at 192.168.202.102@tcp) was lost; in progress operations using this service will wait for recovery to complete [15234.311884] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [15244.720766] Lustre: Unmounted lustre-client [15281.398268] Key type lgssc unregistered [15281.597339] LNet: 277051:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15281.611707] LNetError: 277051:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15281.626595] LNet: Removed LNI 192.168.202.2@tcp [15282.123329] Key type .llcrypt unregistered [15282.125158] Key type ._llcrypt unregistered [15298.115867] Key type ._llcrypt registered [15298.118455] Key type .llcrypt registered [15299.342940] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 05:11:44 (1787476304) [15301.048455] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [15302.696495] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 05:11:47 (1787476307) [15304.140589] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [15305.790651] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 05:11:51 (1787476311) [15307.795916] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [15309.808559] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 05:11:54 (1787476314) [15312.204966] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [15314.447171] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 05:11:59 (1787476319) [15316.525880] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [15319.171167] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 05:12:03 (1787476323) [15332.951632] Key type .llcrypt unregistered [15332.954357] Key type ._llcrypt unregistered [15344.580058] Key type ._llcrypt registered [15344.586070] Key type .llcrypt registered [15345.260651] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15345.273196] alg: No test for adler32 (adler32-zlib) [15346.611770] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [15347.118723] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [15349.056409] Key type lgssc registered [15350.683595] Lustre: Echo OBD driver; http://www.lustre.org/ [15441.124921] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15448.522681] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15475.559686] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15477.442876] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [15481.345976] Lustre: Unmounted lustre-client [15520.635730] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 05:15:25 (1787476525) [15557.866419] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15564.501174] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15601.065870] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15601.749756] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [15604.199137] Lustre: Unmounted lustre-client [15648.898593] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 05:17:33 (1787476653) [15662.559763] LNet: 1 local NIs in recovery (showing 1): 192.168.202.2@tcp [16310.236316] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16318.116295] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16356.881184] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16462.332286] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 05:31:07 (1787477467) [16473.947897] Key type lgssc unregistered [16474.201226] LNet: 290585:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16474.225672] LNetError: 290585:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16475.306881] LNet: Removed LNI 192.168.202.2@tcp [16475.873876] Key type .llcrypt unregistered [16475.876817] Key type ._llcrypt unregistered [16604.734866] Key type ._llcrypt registered [16604.741888] Key type .llcrypt registered [16605.147432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [16605.166703] alg: No test for adler32 (adler32-zlib) [16606.405821] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [16606.800869] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [16608.497478] Key type lgssc registered [16609.771191] Lustre: Echo OBD driver; http://www.lustre.org/ [16713.511388] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16721.092580] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16747.789696] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16783.745070] Key type lgssc unregistered [16784.022963] LNet: 294295:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16784.027970] LNetError: 294295:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16784.066059] LNet: Removed LNI 192.168.202.2@tcp [16785.092900] Key type .llcrypt unregistered [16785.099120] Key type ._llcrypt unregistered [16799.700221] Key type ._llcrypt registered [16799.702565] Key type .llcrypt registered [16800.950400] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 05:36:46 (1787477806) [16825.514398] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16825.600514] alg: No test for adler32 (adler32-zlib) [16826.905148] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [16827.156601] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [16828.919678] Key type lgssc registered [16830.232502] Lustre: Echo OBD driver; http://www.lustre.org/ [16884.352591] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 05:38:08 (1787477888) [16899.888418] Key type lgssc unregistered [16900.270061] LNet: 297852:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16900.290785] LNetError: 297852:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16900.313446] LNet: Removed LNI 192.168.202.2@tcp [16900.951868] Key type .llcrypt unregistered [16900.954596] Key type ._llcrypt unregistered [16912.698111] Key type ._llcrypt registered [16912.714191] Key type .llcrypt registered [16913.183464] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [16913.203374] alg: No test for adler32 (adler32-zlib) [16914.228394] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [16914.377529] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [16916.031286] Key type lgssc registered [16917.299625] Lustre: Echo OBD driver; http://www.lustre.org/ [16975.931623] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16982.630875] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [17007.177399] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [17317.683239] LNet: Added LNI 192.168.202.2@tcp50 [8/256/0/180] [17320.867193] LNet: Removed LNI 192.168.202.2@tcp [17323.379859] Lustre: 302263:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffffa08d04e79000: config has no valid NIDs, force dynamic NIDs [17324.723208] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [17324.924452] Lustre: Unmounted lustre-client [17328.360454] Key type lgssc unregistered [17328.854439] LNet: 302525:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17328.865330] LNetError: 302525:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17328.893418] LNet: Removed LNI 192.168.202.2@tcp50 [17329.979457] Key type .llcrypt unregistered [17329.986553] Key type ._llcrypt unregistered [17350.888161] Key type ._llcrypt registered [17350.897528] Key type .llcrypt registered [17351.550682] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [17351.578917] alg: No test for adler32 (adler32-zlib) [17352.769377] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [17353.089674] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [17354.801349] Key type lgssc registered [17356.784970] Lustre: Echo OBD driver; http://www.lustre.org/ [17414.374654] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [17420.619093] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [17431.456716] LNet: Added LNI 192.168.202.2@tcp50 [8/256/0/180] [17432.635906] LNet: Removed LNI 192.168.202.2@tcp [17433.994142] Lustre: 305217:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffffa08d05759800: config has no valid NIDs, force dynamic NIDs [17435.381775] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [17436.243783] Lustre: Unmounted lustre-client [17475.742473] Key type lgssc unregistered [17476.117833] LNet: 306091:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17476.122322] LNetError: 306091:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17476.140738] LNet: Removed LNI 192.168.202.2@tcp50 [17476.856972] Key type .llcrypt unregistered [17476.864932] Key type ._llcrypt unregistered [17489.903364] Key type ._llcrypt registered [17489.915227] Key type .llcrypt registered [17491.411584] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 05:48:16 (1787478496) [17509.031395] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [17509.133646] alg: No test for adler32 (adler32-zlib) [17510.459941] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [17510.849277] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [17512.591262] Key type lgssc registered [17514.044203] Lustre: Echo OBD driver; http://www.lustre.org/ [17592.823545] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [17598.017533] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [17621.684402] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [17663.258857] Key type lgssc unregistered [17663.568248] LNet: 310840:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17663.577553] LNetError: 310840:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17663.598563] LNet: Removed LNI 192.168.202.2@tcp [17664.491839] Key type .llcrypt unregistered [17664.496335] Key type ._llcrypt unregistered [17674.294989] Key type ._llcrypt registered [17674.296930] Key type .llcrypt registered [17675.853064] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 05:51:20 (1787478680) [17678.175969] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [17678.332404] alg: No test for adler32 (adler32-zlib) [17679.913714] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [17680.162511] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [17681.839478] Key type lgssc registered [17683.130568] Lustre: Echo OBD driver; http://www.lustre.org/ [17738.535210] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [17745.031607] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [17767.765337] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [17780.298967] Lustre: Mounted lustre-client - version 2.17.57_65_gc740cad [17847.717220] Lustre: Mounted fs15246-client - version 2.17.57_65_gc740cad [17866.898655] Lustre: Unmounted fs15246-client [17896.890281] Lustre: Unmounted lustre-client [17933.473710] Key type lgssc unregistered [17933.640586] LNet: 315706:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17933.650278] LNetError: 315706:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17933.674090] LNet: Removed LNI 192.168.202.2@tcp [17934.429365] Key type .llcrypt unregistered [17934.434218] Key type ._llcrypt unregistered [17946.443257] Key type ._llcrypt registered [17946.445964] Key type .llcrypt registered [17947.992476] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 05:55:52 (1787478952) [17949.949199] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [17949.980178] alg: No test for adler32 (adler32-zlib) [17950.990620] Lustre: Lustre: Build Version: 2.17.57_65_gc740cad [17951.229948] LNet: Added LNI 192.168.202.2@tcp [8/256/0/180] [17952.919443] Key type lgssc registered [17954.326208] Lustre: Echo OBD driver; http://www.lustre.org/ [18092.355543] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [18098.395682] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [18122.324639] Lustre: DEBUG MARKER: oleg202-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [18224.058738] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 17919 sec ========= 06:00:28 (1787479228) [18226.345777] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 06:00:30 (1787479230) === [18230.667236] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 06:00:35 (1787479235) === [18265.748366] Key type lgssc unregistered [18266.034041] LNet: 324983:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [18266.040410] LNetError: 324983:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [18266.054776] LNet: Removed LNI 192.168.202.2@tcp [18266.819384] Key type .llcrypt unregistered [18266.821810] Key type ._llcrypt unregistered