[ 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-8.fc42 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 438012015 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 0x00000000BFFE2421 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE22BD 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 00227D (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2331 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE23C1 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE23F9 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe22bd-0xbffe2330] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22bc] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2331-0xbffe23c0] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe23c1-0xbffe23f8] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe23f9-0xbffe2420] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001012] APIC: Switch to symmetric I/O mode setup [ 0.003046] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005018] kvm-guest: setup PV IPIs [ 0.008657] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010014] pid_max: default: 32768 minimum: 301 [ 0.011163] LSM: Security Framework initializing [ 0.012059] Yama: becoming mindful. [ 0.013046] SELinux: Initializing. [ 0.014089] *** VALIDATE selinux *** [ 0.022731] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027473] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028167] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029134] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031093] *** VALIDATE tmpfs *** [ 0.032527] *** VALIDATE proc *** [ 0.034229] *** VALIDATE cgroup *** [ 0.035010] *** VALIDATE cgroup2 *** [ 0.036264] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037192] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039031] Spectre V2 : User space: Vulnerable [ 0.040011] Speculative Store Bypass: Vulnerable [ 0.042966] debug: unmapping init [mem 0xffffffffb5e59000-0xffffffffb5e60fff] [ 0.045000] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.045797] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.046028] ... version: 2 [ 0.047014] ... bit width: 48 [ 0.048013] ... generic registers: 4 [ 0.049016] ... value mask: 0000ffffffffffff [ 0.050016] ... max period: 00007fffffffffff [ 0.051022] ... fixed-purpose events: 3 [ 0.052011] ... event mask: 000000070000000f [ 0.053413] rcu: Hierarchical SRCU implementation. [ 0.055718] smp: Bringing up secondary CPUs ... [ 0.056610] x86: Booting SMP configuration: [ 0.057027] .... node #0, CPUs: #1 #2 #3 [ 0.060316] smp: Brought up 1 node, 4 CPUs [ 0.062012] smpboot: Max logical packages: 1 [ 0.063018] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.134042] node 0 deferred pages initialised in 68ms [ 0.136123] devtmpfs: initialized [ 0.138277] x86/mm: Memory block size: 128MB [ 0.142189] gcov: version magic: 0x41383552 [ 0.145317] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.149084] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.151320] pinctrl core: initialized pinctrl subsystem [ 0.153225] [ 0.153879] ************************************************************* [ 0.156012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.158009] ** ** [ 0.160013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.163015] ** ** [ 0.165013] ** This means that this kernel is built to expose internal ** [ 0.167015] ** IOMMU data structures, which may compromise security on ** [ 0.170013] ** your system. ** [ 0.172013] ** ** [ 0.174013] ** If you see this message and you are not debugging the ** [ 0.176015] ** kernel, report this immediately to your vendor! ** [ 0.179015] ** ** [ 0.181013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.183012] ************************************************************* [ 0.186155] NET: Registered protocol family 16 [ 0.187472] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.190059] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.193068] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.196662] cpuidle: using governor menu [ 0.198796] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.202350] PCI: Using configuration type 1 for base access [ 0.204131] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.213121] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.215012] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.218052] cryptd: max_cpu_qlen set to 1000 [ 0.220285] ACPI: Added _OSI(Module Device) [ 0.222013] ACPI: Added _OSI(Processor Device) [ 0.224013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.225015] ACPI: Added _OSI(Processor Aggregator Device) [ 0.231085] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.236168] ACPI: Interpreter enabled [ 0.237043] ACPI: PM: (supports S0 S3 S4 S5) [ 0.238011] ACPI: Using IOAPIC for interrupt routing [ 0.240097] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.242378] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.250607] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.253046] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.256020] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.260072] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.264450] acpiphp: Slot [2] registered [ 0.266111] acpiphp: Slot [5] registered [ 0.268135] acpiphp: Slot [6] registered [ 0.269081] acpiphp: Slot [3] registered [ 0.270160] acpiphp: Slot [4] registered [ 0.272102] acpiphp: Slot [7] registered [ 0.273078] acpiphp: Slot [8] registered [ 0.274071] acpiphp: Slot [9] registered [ 0.275088] acpiphp: Slot [10] registered [ 0.277112] acpiphp: Slot [11] registered [ 0.278086] acpiphp: Slot [12] registered [ 0.280099] acpiphp: Slot [13] registered [ 0.281121] acpiphp: Slot [14] registered [ 0.282088] acpiphp: Slot [15] registered [ 0.284084] acpiphp: Slot [16] registered [ 0.285093] acpiphp: Slot [17] registered [ 0.287122] acpiphp: Slot [18] registered [ 0.288086] acpiphp: Slot [19] registered [ 0.290083] acpiphp: Slot [20] registered [ 0.291108] acpiphp: Slot [21] registered [ 0.292083] acpiphp: Slot [22] registered [ 0.293077] acpiphp: Slot [23] registered [ 0.294138] acpiphp: Slot [24] registered [ 0.295071] acpiphp: Slot [25] registered [ 0.297115] acpiphp: Slot [26] registered [ 0.298135] acpiphp: Slot [27] registered [ 0.300101] acpiphp: Slot [28] registered [ 0.301112] acpiphp: Slot [29] registered [ 0.303093] acpiphp: Slot [30] registered [ 0.304101] acpiphp: Slot [31] registered [ 0.306057] PCI host bridge to bus 0000:00 [ 0.307012] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.309021] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.311017] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.313019] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.315031] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.317027] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.319333] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.321957] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.325126] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.332013] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.334036] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.336013] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.337014] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.340019] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.343381] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.345687] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.348050] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.350722] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.354018] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.365693] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.370014] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.374758] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.382011] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.391016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.406013] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.414548] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.418700] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.424016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.439017] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.449852] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.452254] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.454375] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.456371] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.458233] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.463176] iommu: Default domain type: Passthrough [ 0.464515] SCSI subsystem initialized [ 0.465115] ACPI: bus type USB registered [ 0.466099] usbcore: registered new interface driver usbfs [ 0.468096] usbcore: registered new interface driver hub [ 0.470097] usbcore: registered new device driver usb [ 0.472172] pps_core: LinuxPPS API ver. 1 registered [ 0.473011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.477049] PTP clock support registered [ 0.478136] EDAC MC: Ver: 3.0.0 [ 0.480428] PCI: Using ACPI for IRQ routing [ 0.482603] NetLabel: Initializing [ 0.484014] NetLabel: domain hash size = 128 [ 0.485007] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.486079] NetLabel: unlabeled traffic allowed by default [ 0.488123] vgaarb: loaded [ 0.489213] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.492018] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.500768] clocksource: Switched to clocksource kvm-clock [ 0.600643] VFS: Disk quotas dquot_6.6.0 [ 0.602739] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.605177] *** VALIDATE ramfs *** [ 0.606698] *** VALIDATE hugetlbfs *** [ 0.608553] pnp: PnP ACPI init [ 0.611082] pnp: PnP ACPI: found 6 devices [ 0.630171] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.633139] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.635126] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.637207] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.640246] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.642506] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.645227] NET: Registered protocol family 2 [ 0.647736] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.652494] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.656659] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.663140] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.667107] TCP: Hash tables configured (established 65536 bind 65536) [ 0.669744] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.672555] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.675770] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.679139] NET: Registered protocol family 1 [ 0.682944] RPC: Registered named UNIX socket transport module. [ 0.685318] RPC: Registered udp transport module. [ 0.686962] RPC: Registered tcp transport module. [ 0.689019] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.691207] NET: Registered protocol family 44 [ 0.692831] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.695051] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.697448] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.699231] PCI: CLS 0 bytes, default 64 [ 0.700340] Unpacking initramfs... [ 2.087179] debug: unmapping init [mem 0xffff8ffabcc64000-0xffff8ffabffcffff] [ 2.091420] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.094189] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.098049] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.603771] Initialise system trusted keyrings [ 2.605850] Key type blacklist registered [ 2.607768] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.616797] zbud: loaded [ 2.619770] *** VALIDATE nfs *** [ 2.621081] *** VALIDATE nfs4 *** [ 2.622910] pstore: using deflate compression [ 2.626854] Platform Keyring initialized [ 2.715957] NET: Registered protocol family 38 [ 2.717425] Key type asymmetric registered [ 2.718588] Asymmetric key parser 'x509' registered [ 2.720488] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.723204] io scheduler mq-deadline registered [ 2.725447] io scheduler kyber registered [ 2.727226] io scheduler bfq registered [ 2.729660] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.733221] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.735883] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.738521] ACPI: Power Button [PWRF] [ 2.744146] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.751758] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.761732] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.787533] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.814028] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.820492] Non-volatile memory driver v1.3 [ 2.822029] Linux agpgart interface v0.103 [ 2.851639] virtio_blk virtio1: [vda] 133944 512-byte logical blocks (68.6 MB/65.4 MiB) [ 2.854870] vda: detected capacity change from 0 to 68579328 [ 2.871152] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.874025] vdb: detected capacity change from 0 to 1073741824 [ 2.879769] libphy: Fixed MDIO Bus: probed [ 2.886326] usbcore: registered new interface driver usbserial_generic [ 2.888833] usbserial: USB Serial support registered for generic [ 2.890437] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.893953] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.895721] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.897582] mousedev: PS/2 mouse device common for all mice [ 2.900102] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.902492] rtc_cmos 00:05: RTC can wake from S4 [ 2.906494] rtc_cmos 00:05: registered as rtc0 [ 2.906700] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.908025] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.913239] intel_pstate: CPU model not supported [ 2.915424] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.917389] hid: raw HID events driver (C) Jiri Kosina [ 2.919910] usbcore: registered new interface driver usbhid [ 2.921633] usbhid: USB HID core driver [ 2.922837] drop_monitor: Initializing network drop monitor service [ 2.924760] Initializing XFRM netlink socket [ 2.926428] NET: Registered protocol family 10 [ 2.928756] Segment Routing with IPv6 [ 2.930074] NET: Registered protocol family 17 [ 2.931838] mpls_gso: MPLS GSO support [ 2.936532] RAS: Correctable Errors collector initialized. [ 2.938395] AVX version of gcm_enc/dec engaged. [ 2.939456] AES CTR mode by8 optimization enabled [ 3.023860] sched_clock: Marking stable (3023829631, 0)->(3972006184, -948176553) [ 3.028673] registered taskstats version 1 [ 3.030794] Loading compiled-in X.509 certificates [ 3.032890] zswap: loaded using pool lzo/zbud [ 3.061298] Key type big_key registered [ 3.075614] Key type encrypted registered [ 3.077527] ima: No TPM chip found, activating TPM-bypass! [ 3.079849] ima: Allocated hash algorithm: sha1 [ 3.081631] ima: No architecture policies found [ 3.083300] evm: Initialising EVM extended attributes: [ 3.085138] evm: security.selinux [ 3.086669] evm: security.ima [ 3.087450] evm: security.capability [ 3.088561] evm: HMAC attrs: 0x1 [ 3.090521] rtc_cmos 00:05: setting system clock to 2026-04-03 05:26:01 UTC (1775193961) [ 3.098548] debug: unmapping init [mem 0xffffffffb6e03000-0xffffffffb6ffffff] [ 3.100829] debug: unmapping init [mem 0xffffffffb5b82000-0xffffffffb5e58fff] [ 3.108163] Write protecting the kernel read-only data: 28672k [ 3.111800] debug: unmapping init [mem 0xffffffffb4203000-0xffffffffb43fffff] [ 3.114817] debug: unmapping init [mem 0xffffffffb4b14000-0xffffffffb4bfffff] [ 3.149280] 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.158622] systemd[1]: Detected virtualization kvm. [ 3.160876] systemd[1]: Detected architecture x86-64. [ 3.163072] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.190789] systemd[1]: No hostname configured. [ 3.192844] systemd[1]: Set hostname to . [ 3.195183] random: systemd: uninitialized urandom read (16 bytes read) [ 3.198635] systemd[1]: Initializing machine ID from random generator. [ 3.333185] random: systemd: uninitialized urandom read (16 bytes read) [ 3.336717] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.342213] random: systemd: uninitialized urandom read (16 bytes read) [ 3.345391] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.350710] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Swap. [ OK ] Reached target Timers. [ OK ] Reached target Slices. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Reached target Initrd Root Device. [ OK ] Started 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. 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... [ 4.025559] device-mapper: uevent: version 1.0.3 [ 4.027914] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.738737] virtio_net virtio0 ens2: renamed from eth0 [ 4.766082] random: fast init done [ 4.793241] scsi host0: ata_piix [ 4.893412] scsi host1: ata_piix [ 4.895208] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.897568] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.036447] dracut-initqueue[586]: RTNETLINK answers: File exists [ 9.597151] random: crng init done [ 9.599209] 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.930881] 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 Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Timers. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.000129] printk: systemd: 25 output lines suppressed due to ratelimiting [ 11.395858] SELinux: Disabled at runtime. [ 11.541415] 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.566434] systemd[1]: Detected virtualization kvm. [ 11.572153] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 13.633632] systemd[1]: initrd-switch-root.service: Succeeded. [ 13.641894] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 13.653755] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 13.662688] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 13.678157] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 13.694132] systemd[1]: Starting Journal Service... Starting Journal Service... [ 13.714594] systemd[1]: Mounting Huge Pages File System... Mounting Huge Pages File System... [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Stopped target Switch Root. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on udev Kernel Socket. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ 13.872493] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-getty.slice. [ OK ] Listening on Process Core Dump Socket. Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Initrd File Systems. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Stopped target Initrd Root File System. Mounting Kernel Debug File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting POSIX Message Queue File System... [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted POSIX Message Queue File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started udev Coldplug all Devices. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 15.243972] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 16.462296] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 16.526633] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 17.386054] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 17.526280] EDAC sbridge: Ver: 1.1.2 [ 21.088918] Key type dns_resolver registered [* ] A start job is running for Configur…-only root support (7s / no limit) [** ] A start job is running for Configur…-only root support (8s / no limit)[ 21.828685] NFS: Registering the id_resolver key type [ 21.836431] Key type id_resolver registered [ 21.838555] Key type id_legacy registered [*** ] A start job is running for Configur…-only root support (8s / no limit) [ 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 ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. Starting Restore /run/initramfs on shutdown... [ OK ] Started D-Bus System Message Bus. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ 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 Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg638-client login: [ 81.526345] libcfs: loading out-of-tree module taints kernel. [ 81.583547] Key type ._llcrypt registered [ 81.608598] Key type .llcrypt registered [ 82.349464] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 82.368257] alg: No test for adler32 (adler32-zlib) [ 83.935554] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 84.775634] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 86.567194] Key type lgssc registered [ 88.407439] Lustre: Echo OBD driver; http://www.lustre.org/ [ 254.906324] Lustre: Mounted lustre-client [ 260.231969] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 277.455966] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing check_logdir /tmp/testlogs/ [ 280.546795] Lustre: lustre-OST0000-osc-ffff8ffb08d22000: disconnect after 23s idle [ 282.529994] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing yml_node [ 286.998776] Lustre: DEBUG MARKER: Client: 2.17.51.74 [ 289.475654] Lustre: DEBUG MARKER: MDS: 2.17.51.74 [ 291.930213] Lustre: DEBUG MARKER: OSS: 2.17.51.74 [ 293.831803] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Apr 3 01:30:50 EDT 2026 [ 310.044637] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 311.319019] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 313.721698] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 324.070683] Lustre: Unmounted lustre-client [ 388.332013] hrtimer: interrupt took 4984787 ns [ 424.641430] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 428.194498] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 448.491204] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 483.370433] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 01:34:00 (1775194440) [ 485.800860] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 487.521084] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 01:34:04 (1775194444) [ 518.575836] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 523.169691] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 543.050671] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 543.696386] Lustre: Mounted lustre-client [ 557.092633] LustreError: 14426:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb084d6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 557.195031] Lustre: Unmounted lustre-client [ 587.730587] Key type lgssc unregistered [ 588.197151] LNet: 14835:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 588.214972] LNetError: 14835:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 588.242945] LNet: Removed LNI 192.168.206.38@tcp [ 589.276307] Key type .llcrypt unregistered [ 589.280070] Key type ._llcrypt unregistered [ 604.228681] Key type ._llcrypt registered [ 604.230660] Key type .llcrypt registered [ 605.521436] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 01:36:02 (1775194562) [ 607.154040] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 607.179102] alg: No test for adler32 (adler32-zlib) [ 608.269317] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 608.494271] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 610.191989] Key type lgssc registered [ 611.217463] Lustre: Echo OBD driver; http://www.lustre.org/ [ 685.978956] Lustre: Mounted lustre-client [ 776.401357] LustreError: 18172:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0785e800: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 776.460087] Lustre: Unmounted lustre-client [ 800.040484] Key type lgssc unregistered [ 800.322682] LNet: 18635:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 800.330652] LNetError: 18635:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 800.343363] LNet: Removed LNI 192.168.206.38@tcp [ 801.021450] Key type .llcrypt unregistered [ 801.024379] Key type ._llcrypt unregistered [ 810.966174] Key type ._llcrypt registered [ 810.967714] Key type .llcrypt registered [ 812.313719] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 01:39:29 (1775194769) [ 815.721164] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 815.761934] alg: No test for adler32 (adler32-zlib) [ 817.067871] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 817.466118] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 819.255381] Key type lgssc registered [ 821.256037] Lustre: Echo OBD driver; http://www.lustre.org/ [ 868.620148] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 873.104743] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 892.325377] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 895.092207] Lustre: Mounted lustre-client [ 904.689679] LustreError: 21752:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb08d22000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 904.786048] Lustre: Unmounted lustre-client [ 941.456781] Key type lgssc unregistered [ 941.734507] LNet: 22159:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 941.752844] LNetError: 22159:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 941.790802] LNet: Removed LNI 192.168.206.38@tcp [ 942.475378] Key type .llcrypt unregistered [ 942.481185] Key type ._llcrypt unregistered [ 952.349861] Key type ._llcrypt registered [ 952.356539] Key type .llcrypt registered [ 953.611301] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 01:41:50 (1775194910) [ 956.331748] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 956.348354] alg: No test for adler32 (adler32-zlib) [ 957.488080] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 957.722606] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 959.440289] Key type lgssc registered [ 960.762801] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1009.138902] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1013.958381] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1035.500276] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1038.177607] Lustre: Mounted lustre-client [ 1043.638877] LustreError: 24866:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0808c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1043.728165] Lustre: Unmounted lustre-client [ 1069.935191] Key type lgssc unregistered [ 1070.208199] LNet: 25268:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1070.214851] LNetError: 25268:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1070.236516] LNet: Removed LNI 192.168.206.38@tcp [ 1071.009365] Key type .llcrypt unregistered [ 1071.016963] Key type ._llcrypt unregistered [ 1086.051852] Key type ._llcrypt registered [ 1086.055451] Key type .llcrypt registered [ 1087.744315] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 01:44:04 (1775195044) [ 1090.386624] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1090.543519] alg: No test for adler32 (adler32-zlib) [ 1091.704232] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 1091.968723] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 1093.647283] Key type lgssc registered [ 1094.943662] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1146.769744] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1150.509688] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1169.767270] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1172.452159] Lustre: Mounted lustre-client [ 1177.586600] Lustre: lustre-MDT0000-mdc-ffff8ffb11c07800: Connection to lustre-MDT0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1187.822289] Lustre: lustre-MDT0001-mdc-ffff8ffb11c07800: Connection to lustre-MDT0001 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1191.315262] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1199.071465] Lustre: 26228:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775195141/real 1775195141] req@000000006d4afa52 x1861426924754432/t0(0) o400->MGC192.168.206.138@tcp@192.168.206.138@tcp:26/25 lens 224/224 e 0 to 1 dl 1775195157 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1199.109089] LustreError: MGC192.168.206.138@tcp: Connection to MGS (at 192.168.206.138@tcp) was lost; in progress operations using this service will fail [ 1201.625289] Lustre: Unmounted lustre-client [ 1220.565956] Key type lgssc unregistered [ 1220.848230] LNet: 28843:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1220.859556] LNetError: 28843:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1220.892059] LNet: Removed LNI 192.168.206.38@tcp [ 1221.617758] Key type .llcrypt unregistered [ 1221.625950] Key type ._llcrypt unregistered [ 1238.473683] Key type ._llcrypt registered [ 1238.478962] Key type .llcrypt registered [ 1240.012163] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 01:46:36 (1775195196) [ 1243.486769] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1243.508594] alg: No test for adler32 (adler32-zlib) [ 1244.547362] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 1244.747181] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 1246.431377] Key type lgssc registered [ 1247.539820] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1295.112926] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1299.216693] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1319.686188] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1322.480732] Lustre: Mounted lustre-client [ 1327.599702] Lustre: lustre-OST0000-osc-ffff8ffb0848b000: Connection to lustre-OST0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1334.135773] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1344.529545] Lustre: Unmounted lustre-client [ 1388.048643] Key type lgssc unregistered [ 1388.310942] LNet: 32378:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1388.317424] LNetError: 32378:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1388.335647] LNet: Removed LNI 192.168.206.38@tcp [ 1388.912134] Key type .llcrypt unregistered [ 1388.917517] Key type ._llcrypt unregistered [ 1403.676216] Key type ._llcrypt registered [ 1403.678541] Key type .llcrypt registered [ 1404.961237] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 01:49:21 (1775195361) [ 1407.164540] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1407.216562] alg: No test for adler32 (adler32-zlib) [ 1408.376152] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 1408.625937] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 1410.337905] Key type lgssc registered [ 1411.903029] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1458.736923] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1462.729442] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1482.624433] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1485.424180] Lustre: Mounted lustre-client [ 1489.362721] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1493.402570] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1504.899963] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-04-03 1h51m01s [ 1507.516387] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1510.902099] Lustre: lustre-MDT0000-mdc-ffff8ffb0597c000: Connection to lustre-MDT0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1517.948612] LustreError: 36085:0:(lmv_obd.c:1437:lmv_statfs()) lustre-MDT0000-mdc-ffff8ffb0597c000: can't stat MDS #0: rc = -19 [ 1519.790496] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1528.299176] LustreError: MGC192.168.206.138@tcp: Connection to MGS (at 192.168.206.138@tcp) was lost; in progress operations using this service will fail [ 1528.320931] Lustre: Evicted from MGS (at 192.168.206.138@tcp) after server handle changed from 0x4c9f97c44f0b9e52 to 0x4c9f97c44f0ba115 [ 1528.332215] Lustre: MGC192.168.206.138@tcp: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [ 1529.389104] LustreError: lustre-MDT0000-mdc-ffff8ffb0597c000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1529.412923] Lustre: lustre-MDT0000-mdc-ffff8ffb0597c000: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [ 1534.418186] Lustre: DEBUG MARKER: Wait for df (36085) ... [ 1535.994949] Lustre: DEBUG MARKER: done [ 1538.077294] LustreError: 36705:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0597c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1538.131330] Lustre: Unmounted lustre-client [ 1573.487759] Key type lgssc unregistered [ 1573.763793] LNet: 37111:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1573.771575] LNetError: 37111:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1573.792523] LNet: Removed LNI 192.168.206.38@tcp [ 1574.678219] Key type .llcrypt unregistered [ 1574.679876] Key type ._llcrypt unregistered [ 1606.415448] Key type ._llcrypt registered [ 1606.416891] Key type .llcrypt registered [ 1607.890891] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 01:52:44 (1775195564) [ 1610.318169] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1610.336954] alg: No test for adler32 (adler32-zlib) [ 1611.408869] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 1611.613660] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 1613.279578] Key type lgssc registered [ 1614.593529] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1658.611699] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1662.243837] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1682.350213] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1685.250321] Lustre: Mounted lustre-client [ 1690.694295] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-04-03 1h54m07s [ 1692.825947] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1700.703919] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1703.344939] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1723.871305] Lustre: 41175:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775195662/real 1775195662] req@00000000c0c84049 x1861427470015104/t0(0) o101->lustre-MDT0000-mdc-ffff8ffb18b2c800@192.168.206.138@tcp:12/10 lens 576/1152 e 0 to 1 dl 1775195682 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1723.902298] Lustre: lustre-MDT0000-mdc-ffff8ffb18b2c800: Connection to lustre-MDT0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1723.938745] Lustre: lustre-MDT0000-mdc-ffff8ffb18b2c800: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [ 1745.283629] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1748.543773] Lustre: DEBUG MARKER: done [ 1754.021599] LustreError: 41651:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb18b2c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1754.199080] Lustre: Unmounted lustre-client [ 1785.048347] Key type lgssc unregistered [ 1785.496887] LNet: 42057:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1785.506092] LNetError: 42057:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1785.531399] LNet: Removed LNI 192.168.206.38@tcp [ 1786.281973] Key type .llcrypt unregistered [ 1786.286344] Key type ._llcrypt unregistered [ 1821.052841] Key type ._llcrypt registered [ 1821.059188] Key type .llcrypt registered [ 1822.440274] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 01:56:19 (1775195779) [ 1823.988646] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1825.815850] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 01:56:22 (1775195782) [ 1830.440581] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1830.457720] alg: No test for adler32 (adler32-zlib) [ 1831.687245] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 1831.974497] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 1833.751604] Key type lgssc registered [ 1835.029619] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1864.498511] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 01:57:01 (1775195821) [ 1899.786365] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1904.292779] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1926.471219] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1929.386324] Lustre: Mounted lustre-client [ 1932.995430] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1937.693156] LustreError: 46413:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0917d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1937.845863] Lustre: Unmounted lustre-client [ 1956.880533] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2008.023142] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2012.953959] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2013.810064] Lustre: Mounted lustre-client [ 2018.132229] LustreError: 47670:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0999e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2018.254924] Lustre: Unmounted lustre-client [ 2088.012520] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2091.934909] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2092.781089] Lustre: Mounted lustre-client [ 2097.033674] LustreError: 48790:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb050fc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2097.215509] Lustre: Unmounted lustre-client [ 2123.917610] Lustre: DEBUG MARKER: files compared the same [ 2149.692301] Key type lgssc unregistered [ 2150.051986] LNet: 49510:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2150.062985] LNetError: 49510:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2150.107470] LNet: Removed LNI 192.168.206.38@tcp [ 2151.199720] Key type .llcrypt unregistered [ 2151.203611] Key type ._llcrypt unregistered [ 2171.498640] Key type ._llcrypt registered [ 2171.502624] Key type .llcrypt registered [ 2173.093374] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 02:02:09 (1775196129) [ 2176.642944] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2176.827341] alg: No test for adler32 (adler32-zlib) [ 2178.267275] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 2178.739624] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 2180.623629] Key type lgssc registered [ 2182.384526] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2243.968183] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2248.339163] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2272.759969] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2275.710727] Lustre: Mounted lustre-client [ 2284.144238] LustreError: 52614:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb09179000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2284.278272] Lustre: Unmounted lustre-client [ 2318.895080] Key type lgssc unregistered [ 2319.206760] LNet: 53019:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2319.215786] LNetError: 53019:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2319.231177] LNet: Removed LNI 192.168.206.38@tcp [ 2319.856122] Key type .llcrypt unregistered [ 2319.861290] Key type ._llcrypt unregistered [ 2337.977655] Key type ._llcrypt registered [ 2337.980280] Key type .llcrypt registered [ 2339.763751] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 02:04:56 (1775196296) [ 2343.296929] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2343.431433] alg: No test for adler32 (adler32-zlib) [ 2345.029741] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 2345.621541] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 2347.487270] Key type lgssc registered [ 2349.416271] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2440.027708] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2478.917777] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2483.272995] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2515.988616] Key type lgssc unregistered [ 2516.298753] LNet: 56421:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2516.307459] LNetError: 56421:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2516.342235] LNet: Removed LNI 192.168.206.38@tcp [ 2517.206302] Key type .llcrypt unregistered [ 2517.209118] Key type ._llcrypt unregistered [ 2533.822474] Key type ._llcrypt registered [ 2533.824245] Key type .llcrypt registered [ 2534.458281] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 02:08:12 (1775196492) [ 2535.903828] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2535.959964] alg: No test for adler32 (adler32-zlib) [ 2536.901240] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 2537.026838] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 2538.607141] Key type lgssc registered [ 2539.580496] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2645.555686] Lustre: Mounted lustre-client [ 2654.232868] LustreError: 58918:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb10811000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2654.353321] Lustre: Unmounted lustre-client [ 2691.909864] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 02:10:48 (1775196648) [ 2816.081756] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2839.092068] Lustre: Mounted lustre-client [ 2848.528886] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2848.550864] LustreError: 62877:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8ffb0827a800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2848.609630] Lustre: 57405:0:(llite_lib.c:4149:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.138@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2859.005773] Lustre: Unmounted lustre-client [ 2925.772419] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 02:14:42 (1775196882) [ 2940.070642] Key type lgssc unregistered [ 2940.434719] LNet: 64094:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2940.444568] LNetError: 64094:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2940.463633] LNet: Removed LNI 192.168.206.38@tcp [ 2941.209270] Key type .llcrypt unregistered [ 2941.211272] Key type ._llcrypt unregistered [ 2955.260265] Key type ._llcrypt registered [ 2955.265100] Key type .llcrypt registered [ 2956.181455] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2956.211831] alg: No test for adler32 (adler32-zlib) [ 2957.427657] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 2957.740135] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 2959.440579] Key type lgssc registered [ 2961.429715] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3019.103893] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3024.121349] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3048.010710] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3050.829957] Lustre: Mounted lustre-client [ 3059.313644] LustreError: 66627:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb08d21000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3059.436385] Lustre: Unmounted lustre-client [ 3092.566229] Key type lgssc unregistered [ 3092.989458] LNet: 67031:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3093.001486] LNetError: 67031:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3094.057365] LNet: Removed LNI 192.168.206.38@tcp [ 3095.012203] Key type .llcrypt unregistered [ 3095.023772] Key type ._llcrypt unregistered [ 3109.192897] Key type ._llcrypt registered [ 3109.210112] Key type .llcrypt registered [ 3110.166354] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3110.196839] alg: No test for adler32 (adler32-zlib) [ 3111.431959] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 3111.813154] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 3113.631330] Key type lgssc registered [ 3115.108903] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3225.661843] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3230.311053] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3254.182037] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3257.101983] Lustre: Mounted lustre-client [ 3259.728192] LustreError: 69985:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb05eb8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3259.880206] Lustre: Unmounted lustre-client [ 3291.943768] Key type lgssc unregistered [ 3292.208467] LNet: 70389:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3292.220831] LNetError: 70389:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3292.253864] LNet: Removed LNI 192.168.206.38@tcp [ 3293.287137] Key type .llcrypt unregistered [ 3293.290940] Key type ._llcrypt unregistered [ 3313.311377] Key type ._llcrypt registered [ 3313.316403] Key type .llcrypt registered [ 3315.272345] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 02:21:11 (1775197271) [ 3317.954875] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3317.988392] alg: No test for adler32 (adler32-zlib) [ 3318.987252] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 3319.299377] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 3321.031225] Key type lgssc registered [ 3322.545061] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3378.396581] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3384.064888] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3407.572042] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3410.436673] Lustre: Mounted lustre-client [ 3418.767887] LustreError: 73515:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb03b95000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3418.909567] Lustre: Unmounted lustre-client [ 3419.626838] Lustre: Mounted lustre-client [ 3423.300375] LustreError: 73594:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0597b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3423.416943] Lustre: Unmounted lustre-client [ 3455.310090] Key type lgssc unregistered [ 3455.707288] LNet: 73997:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3455.718970] LNetError: 73997:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3455.737501] LNet: Removed LNI 192.168.206.38@tcp [ 3456.801385] Key type .llcrypt unregistered [ 3456.805981] Key type ._llcrypt unregistered [ 3472.341081] Key type ._llcrypt registered [ 3472.346554] Key type .llcrypt registered [ 3472.690540] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3472.722577] alg: No test for adler32 (adler32-zlib) [ 3473.995888] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 3474.281881] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 3476.007202] Key type lgssc registered [ 3477.804162] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3536.425424] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3541.646550] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3565.606625] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3567.530042] Lustre: Mounted lustre-client [ 3573.145352] LustreError: 76545:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb04f57000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3573.258326] Lustre: Unmounted lustre-client [ 3603.991128] Key type lgssc unregistered [ 3604.429166] LNet: 76947:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3604.445293] LNetError: 76947:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3604.480326] LNet: Removed LNI 192.168.206.38@tcp [ 3605.231781] Key type .llcrypt unregistered [ 3605.234274] Key type ._llcrypt unregistered [ 3622.337420] Key type ._llcrypt registered [ 3622.339713] Key type .llcrypt registered [ 3624.024905] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 02:26:20 (1775197580) [ 3627.094447] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3627.124455] alg: No test for adler32 (adler32-zlib) [ 3628.393048] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 3628.659856] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 3630.375217] Key type lgssc registered [ 3632.216109] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3688.935948] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3693.568900] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3711.771573] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3714.734952] Lustre: Mounted lustre-client [ 3721.563346] Lustre: lustre: root_squash is set to 0:0 [ 3730.522912] Lustre: lustre: nosquash_nids is cleared [ 3739.263581] Lustre: lustre: root_squash is set to 500:500 [ 3748.544524] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.38@tcp 192.168.0.[2,10]@tcp [ 3757.416523] Lustre: lustre: nosquash_nids set to 192.168.206.38/24@tcp [ 3762.557717] LustreError: 80417:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb18b2f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3762.663726] Lustre: Unmounted lustre-client [ 3789.636508] Key type lgssc unregistered [ 3789.864739] LNet: 80821:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3789.875768] LNetError: 80821:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3789.897686] LNet: Removed LNI 192.168.206.38@tcp [ 3790.499940] Key type .llcrypt unregistered [ 3790.503577] Key type ._llcrypt unregistered [ 3804.876954] Key type ._llcrypt registered [ 3804.881313] Key type .llcrypt registered [ 3806.512901] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 02:29:23 (1775197763) [ 3808.677549] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3810.451487] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 02:29:27 (1775197767) [ 3812.818392] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3812.866066] alg: No test for adler32 (adler32-zlib) [ 3814.157478] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 3814.552182] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 3816.377735] Key type lgssc registered [ 3817.797424] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3869.714941] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3873.869888] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3894.225140] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3895.942991] Lustre: lustre: root_squash is set to 500:500 [ 3896.022439] Lustre: lustre: nosquash_nids set to 192.168.206.38/24@tcp [ 3897.143087] Lustre: Mounted lustre-client [ 3903.768344] LustreError: 84293:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb11c05800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3903.844225] Lustre: Unmounted lustre-client [ 3930.781754] Key type lgssc unregistered [ 3931.028309] LNet: 84697:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3931.037365] LNetError: 84697:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3931.061775] LNet: Removed LNI 192.168.206.38@tcp [ 3931.748634] Key type .llcrypt unregistered [ 3931.758446] Key type ._llcrypt unregistered [ 3945.897730] Key type ._llcrypt registered [ 3945.900616] Key type .llcrypt registered [ 3947.302447] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3948.874395] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 02:31:45 (1775197905) [ 3965.350657] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3965.438702] alg: No test for adler32 (adler32-zlib) [ 3966.649327] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 3966.886052] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 3968.615175] Key type lgssc registered [ 3969.993640] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4049.361768] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4053.634562] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4076.379656] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4138.073155] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4142.277640] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4165.761061] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4178.763188] Lustre: Mounted lustre-client [ 4216.978285] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8ffb04f57000.ost_server_uuid 50 [ 4219.170974] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8ffb04f57000.ost_server_uuid in IDLE state after 0 sec [ 4219.720730] Lustre: Mounted lustre-client [ 4224.071923] LustreError: 91609:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb057ed000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4224.246247] Lustre: Unmounted lustre-client [ 4227.586487] LustreError: 91629:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb04f57000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4227.594842] LustreError: 91629:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [ 4227.758308] Lustre: Unmounted lustre-client [ 4280.849367] Key type lgssc unregistered [ 4281.194749] LNet: 92185:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4281.206422] LNetError: 92185:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4281.247344] LNet: Removed LNI 192.168.206.38@tcp [ 4282.168182] Key type .llcrypt unregistered [ 4282.170902] Key type ._llcrypt unregistered [ 4311.788709] Key type ._llcrypt registered [ 4311.790718] Key type .llcrypt registered [ 4313.256832] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 02:37:50 (1775198270) [ 4330.778937] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4330.807773] alg: No test for adler32 (adler32-zlib) [ 4331.839519] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 4332.170805] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 4333.983281] Key type lgssc registered [ 4336.047523] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4413.004157] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4416.679628] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4435.538574] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4438.179185] Lustre: Mounted lustre-client [ 4460.001638] Lustre: 93550:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775198402/real 1775198402] req@0000000028f917e9 x1861430322140416/t0(0) o400->lustre-OST0000-osc-ffff8ffb04a87000@192.168.206.138@tcp:28/4 lens 224/224 e 0 to 1 dl 1775198418 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4460.017823] Lustre: lustre-OST0000-osc-ffff8ffb04a87000: Connection to lustre-OST0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4464.867931] Lustre: 93549:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775198407/real 1775198407] req@00000000f03c7f02 x1861430322140928/t0(0) o400->lustre-OST0000-osc-ffff8ffb04a87000@192.168.206.138@tcp:28/4 lens 224/224 e 0 to 1 dl 1775198423 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4470.240244] Lustre: 93550:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775198412/real 1775198412] req@00000000f97f3f34 x1861430322141440/t0(0) o400->lustre-OST0000-osc-ffff8ffb04a87000@192.168.206.138@tcp:28/4 lens 224/224 e 0 to 1 dl 1775198428 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4475.362603] Lustre: 93549:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775198417/real 1775198417] req@00000000a746ed67 x1861430322141952/t0(0) o400->lustre-OST0000-osc-ffff8ffb04a87000@192.168.206.138@tcp:28/4 lens 224/224 e 0 to 1 dl 1775198433 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4475.399190] Lustre: lustre-MDT0000-mdc-ffff8ffb04a87000: Connection to lustre-MDT0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4489.185475] Lustre: 96634:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775198431/real 1775198431] req@0000000062902ee9 x1861430322143744/t0(0) o101->MGC192.168.206.138@tcp@192.168.206.138@tcp:26/25 lens 328/344 e 0 to 1 dl 1775198447 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4489.210323] LustreError: MGC192.168.206.138@tcp: Connection to MGS (at 192.168.206.138@tcp) was lost; in progress operations using this service will fail [ 4489.225913] Lustre: 96634:0:(mgc_request.c:1917:mgc_process_log()) MGC192.168.206.138@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 4493.379278] Lustre: lustre-OST0000-osc-ffff8ffb04a87000: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [ 4498.893330] Lustre: lustre-MDT0000-mdc-ffff8ffb04a87000: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [ 4499.435217] Lustre: Evicted from MGS (at 192.168.206.138@tcp) after server handle changed from 0xf342fb2c43e69c93 to 0xf342fb2c43e6a005 [ 4503.276472] LustreError: 97370:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb04a87000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4503.352658] Lustre: Unmounted lustre-client [ 4531.686199] Key type lgssc unregistered [ 4531.896166] LNet: 97774:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4531.903807] LNetError: 97774:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4531.918424] LNet: Removed LNI 192.168.206.38@tcp [ 4532.669668] Key type .llcrypt unregistered [ 4532.678210] Key type ._llcrypt unregistered [ 4549.409817] Key type ._llcrypt registered [ 4549.412823] Key type .llcrypt registered [ 4550.643434] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 02:41:47 (1775198507) [ 4565.306127] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4565.355585] alg: No test for adler32 (adler32-zlib) [ 4566.420118] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 4566.665901] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 4568.321859] Key type lgssc registered [ 4569.410501] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4600.396213] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4698.087926] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4703.315630] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4726.331683] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4728.082155] Lustre: Mounted lustre-client [ 4729.933628] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4731.840642] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 02:44:48 (1775198688) [ 5009.173857] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5019.483606] Lustre: Unmounted lustre-client [ 5159.610392] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5164.762073] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5189.011762] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5233.563402] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 02:53:10 (1775199190) [ 5325.133783] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5329.250501] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5352.704350] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5353.417897] Lustre: Mounted lustre-client [ 5358.394966] LustreError: 115979:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb050fc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5358.540507] Lustre: Unmounted lustre-client [ 5399.320593] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 02:55:56 (1775199356) [ 5500.352295] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5504.559638] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5530.830452] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5531.493497] Lustre: Mounted lustre-client [ 5537.257332] LustreError: 120032:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb058b1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5537.356190] Lustre: Unmounted lustre-client [ 5568.614360] Key type lgssc unregistered [ 5569.019455] LNet: 120438:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5569.028520] LNetError: 120438:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5569.051775] LNet: Removed LNI 192.168.206.38@tcp [ 5569.879222] Key type .llcrypt unregistered [ 5569.882052] Key type ._llcrypt unregistered [ 5591.678443] Key type ._llcrypt registered [ 5591.686267] Key type .llcrypt registered [ 5593.663857] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 02:59:09 (1775199549) [ 5597.573204] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5597.741502] alg: No test for adler32 (adler32-zlib) [ 5599.095320] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 5599.405936] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 5601.239255] Key type lgssc registered [ 5603.425826] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5666.706850] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5670.407526] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5692.538561] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5694.327062] Lustre: Mounted lustre-client [ 5708.951877] LustreError: 123557:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0560c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5709.091074] Lustre: Unmounted lustre-client [ 5742.434549] Key type lgssc unregistered [ 5742.832401] LNet: 123961:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5742.842059] LNetError: 123961:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5742.878508] LNet: Removed LNI 192.168.206.38@tcp [ 5744.209680] Key type .llcrypt unregistered [ 5744.221438] Key type ._llcrypt unregistered [ 5764.693782] Key type ._llcrypt registered [ 5764.698546] Key type .llcrypt registered [ 5766.744613] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 03:02:02 (1775199722) [ 5770.419083] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5770.435802] alg: No test for adler32 (adler32-zlib) [ 5771.765510] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 5772.038794] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 5773.823255] Key type lgssc registered [ 5775.687354] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5831.744964] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5836.755031] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5859.158678] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5862.047842] Lustre: Mounted lustre-client [ 5867.513191] Lustre: lustre-OST0000-osc-ffff8ffb05532800: Connection to lustre-OST0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5879.515351] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8ffb05532800.ost_server_uuid 50 [ 5881.363809] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5892.971500] LustreError: 127510:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb05532800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5893.071306] Lustre: Unmounted lustre-client [ 5921.372544] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 03:04:37 (1775199877) [ 5957.629284] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5961.895912] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5984.012662] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6007.172363] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6008.120687] Lustre: Mounted lustre-client [ 6013.434184] Lustre: lustre-OST0000-osc-ffff8ffb04f50800: Connection to lustre-OST0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6048.653386] LustreError: 130169:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb04f50800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6048.806139] Lustre: Unmounted lustre-client [ 6106.036598] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 03:07:42 (1775200062) [ 6141.422916] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6146.230761] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6167.911370] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6189.466089] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6190.145887] Lustre: Mounted lustre-client [ 6195.181272] Lustre: lustre-OST0000-osc-ffff8ffb0747d800: Connection to lustre-OST0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6211.878962] LustreError: 132934:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0747d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6211.891975] LustreError: 132934:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [ 6212.020466] Lustre: Unmounted lustre-client [ 6270.897306] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 03:10:27 (1775200227) [ 6371.635385] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6375.687458] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6398.566207] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6475.084476] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6480.350783] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6501.542209] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6534.990530] Lustre: Mounted lustre-client [ 6580.571468] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6582.780825] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6585.209259] LustreError: 139546:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb08d22000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6585.223921] LustreError: 139546:0:(lov_obd.c:786:lov_cleanup()) Skipped 1 previous similar message [ 6585.366320] Lustre: Unmounted lustre-client [ 6619.858150] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 03:16:16 (1775200576) [ 6651.537695] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6655.585239] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6677.027600] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6713.354608] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6751.558100] Lustre: Mounted lustre-client [ 6793.052451] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6794.775631] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6797.803238] Lustre: lustre-OST0001-osc-ffff8ffb05536800: Connection to lustre-OST0001 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6806.837655] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6817.264155] Lustre: Unmounted lustre-client [ 6882.734641] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 03:20:39 (1775200839) [ 6917.590850] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6922.082671] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6945.382985] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6946.242492] Lustre: Mounted lustre-client [ 6971.199623] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6973.203747] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6989.689588] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8ffb107ba800.ost_server_uuid 50 [ 6991.468667] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8ffb107ba800.ost_server_uuid in IDLE state after 0 sec [ 6995.737890] LustreError: 146577:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb107ba800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6995.874409] Lustre: Unmounted lustre-client [ 6996.212255] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6996.230883] Lustre: Skipped 3 previous similar messages [ 6996.425786] Lustre: Mounted lustre-client [ 6997.555644] LustreError: 146642:0:(sec.c:413:import_sec_validate_get()) import 00000000382c5be3 (NEW) with no sec [ 7073.178116] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 03:23:49 (1775201029) [ 7108.471436] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7113.428384] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7135.030989] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7157.839817] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7158.376071] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7158.644381] Lustre: Mounted lustre-client [ 7173.964937] LustreError: 149502:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb05533000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7173.981893] LustreError: 149502:0:(lov_obd.c:786:lov_cleanup()) Skipped 2 previous similar messages [ 7174.143639] Lustre: Unmounted lustre-client [ 7174.147601] Lustre: Skipped 1 previous similar message [ 7216.408358] Key type lgssc unregistered [ 7216.762569] LNet: 149955:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7216.776840] LNetError: 149955:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7216.804364] LNet: Removed LNI 192.168.206.38@tcp [ 7217.645683] Key type .llcrypt unregistered [ 7217.648525] Key type ._llcrypt unregistered [ 7236.283102] Key type ._llcrypt registered [ 7236.298425] Key type .llcrypt registered [ 7238.023175] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 03:26:34 (1775201194) [ 7239.428983] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7239.482208] alg: No test for adler32 (adler32-zlib) [ 7240.571077] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 7240.890977] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 7242.599342] Key type lgssc registered [ 7244.230984] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7301.687539] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7305.809809] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7328.265745] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7349.258680] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7349.974677] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7351.160594] Lustre: Mounted lustre-client [ 7355.382371] LustreError: lustre-MDT0001-mdc-ffff8ffb07478000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7355.425462] Lustre: lustre-MDT0001-mdc-ffff8ffb07478000: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [ 7360.516801] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7362.226492] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7386.646365] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7391.243423] LustreError: 154184:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb07478000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7391.353623] Lustre: Unmounted lustre-client [ 7424.164220] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 03:29:40 (1775201380) [ 7530.484559] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7535.028778] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7560.715884] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7561.530216] Lustre: Mounted lustre-client [ 7588.841088] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7591.101751] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7603.264578] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7613.639083] Lustre: Unmounted lustre-client [ 7649.632403] Key type lgssc unregistered [ 7649.933780] LNet: 159331:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7649.945609] LNetError: 159331:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7649.967119] LNet: Removed LNI 192.168.206.38@tcp [ 7650.611995] Key type .llcrypt unregistered [ 7650.622113] Key type ._llcrypt unregistered [ 7682.685225] Key type ._llcrypt registered [ 7682.688706] Key type .llcrypt registered [ 7684.560608] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 03:34:00 (1775201640) [ 7687.296072] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7687.339171] alg: No test for adler32 (adler32-zlib) [ 7688.584776] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 7688.952677] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 7690.687270] Key type lgssc registered [ 7692.219631] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7740.595632] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7744.868281] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7764.203760] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7765.751469] Lustre: Mounted lustre-client [ 7812.290527] LustreError: 162609:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb07858800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7812.412558] Lustre: Unmounted lustre-client [ 7853.963718] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7854.560089] Lustre: Mounted lustre-client [ 7890.496501] LustreError: 163270:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb050f9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7890.624273] Lustre: Unmounted lustre-client [ 7919.806732] Key type lgssc unregistered [ 7920.152860] LNet: 163677:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7920.167160] LNetError: 163677:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7920.186651] LNet: Removed LNI 192.168.206.38@tcp [ 7920.863432] Key type .llcrypt unregistered [ 7920.866755] Key type ._llcrypt unregistered [ 7939.193482] Key type ._llcrypt registered [ 7939.197225] Key type .llcrypt registered [ 7941.124986] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 03:38:17 (1775201897) [ 7943.905267] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7943.976105] alg: No test for adler32 (adler32-zlib) [ 7945.083906] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 7945.359758] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 7947.055859] Key type lgssc registered [ 7948.493837] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7995.194192] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7998.836892] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8017.172257] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8024.122552] Lustre: Mounted lustre-client [ 8042.143706] LustreError: 166949:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb05587800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8042.239620] Lustre: Unmounted lustre-client [ 8069.342905] Key type lgssc unregistered [ 8069.562357] LNet: 167353:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8069.569934] LNetError: 167353:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8069.582646] LNet: Removed LNI 192.168.206.38@tcp [ 8070.249973] Key type .llcrypt unregistered [ 8070.253415] Key type ._llcrypt unregistered [ 8082.057621] Key type ._llcrypt registered [ 8082.063135] Key type .llcrypt registered [ 8082.707426] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8082.743345] alg: No test for adler32 (adler32-zlib) [ 8083.939363] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 8084.290182] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 8086.063769] Key type lgssc registered [ 8087.538792] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8139.815845] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8144.401883] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8164.551478] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8166.426794] Lustre: Mounted lustre-client [ 8174.464605] LustreError: 169931:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb05e9e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8174.601805] Lustre: Unmounted lustre-client [ 8203.417498] Key type lgssc unregistered [ 8203.740070] LNet: 170334:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8203.751072] LNetError: 170334:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8203.773244] LNet: Removed LNI 192.168.206.38@tcp [ 8204.542852] Key type .llcrypt unregistered [ 8204.547299] Key type ._llcrypt unregistered [ 8221.195201] Key type ._llcrypt registered [ 8221.198112] Key type .llcrypt registered [ 8223.036362] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 03:42:59 (1775202179) [ 8225.552760] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8225.606268] alg: No test for adler32 (adler32-zlib) [ 8226.773185] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 8227.100169] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 8228.865101] Key type lgssc registered [ 8230.380772] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8284.024773] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8289.658721] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8313.239822] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8315.922586] Lustre: Mounted lustre-client [ 8336.952304] LustreError: 173603:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0597d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8337.060915] Lustre: Unmounted lustre-client [ 8365.858115] Key type lgssc unregistered [ 8366.216156] LNet: 174008:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8366.232154] LNetError: 174008:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8366.267692] LNet: Removed LNI 192.168.206.38@tcp [ 8367.031330] Key type .llcrypt unregistered [ 8367.033833] Key type ._llcrypt unregistered [ 8379.674798] Key type ._llcrypt registered [ 8379.677324] Key type .llcrypt registered [ 8380.199334] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8380.217283] alg: No test for adler32 (adler32-zlib) [ 8381.261759] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 8381.508275] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 8383.217535] Key type lgssc registered [ 8384.724626] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8436.564472] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8440.877511] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8462.161763] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8464.009258] Lustre: Mounted lustre-client [ 8472.782369] LustreError: 176590:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb04728000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8472.920195] Lustre: Unmounted lustre-client [ 8502.829086] Key type lgssc unregistered [ 8503.068545] LNet: 176995:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8503.082952] LNetError: 176995:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8503.107414] LNet: Removed LNI 192.168.206.38@tcp [ 8503.888826] Key type .llcrypt unregistered [ 8503.894873] Key type ._llcrypt unregistered [ 8520.591751] Key type ._llcrypt registered [ 8520.600785] Key type .llcrypt registered [ 8522.453419] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 03:47:58 (1775202478) [ 8548.114883] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8548.159919] alg: No test for adler32 (adler32-zlib) [ 8549.395269] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 8549.757621] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 8551.447579] Key type lgssc registered [ 8552.781223] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8634.625741] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8640.472762] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8663.412621] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8704.231496] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 03:51:01 (1775202661) [ 8734.494956] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8738.461726] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8757.246549] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8759.318373] Lustre: Mounted lustre-client [ 8764.536800] LustreError: 183521:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb05e9a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8764.646334] Lustre: Unmounted lustre-client [ 8791.519445] Key type lgssc unregistered [ 8791.764033] LNet: 183925:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8791.771242] LNetError: 183925:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8791.787883] LNet: Removed LNI 192.168.206.38@tcp [ 8792.467963] Key type .llcrypt unregistered [ 8792.469568] Key type ._llcrypt unregistered [ 8807.935119] Key type ._llcrypt registered [ 8807.938148] Key type .llcrypt registered [ 8809.345368] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8810.878521] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 03:52:47 (1775202767) [ 8828.414514] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8828.489312] alg: No test for adler32 (adler32-zlib) [ 8829.656584] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 8829.957517] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 8831.759197] Key type lgssc registered [ 8833.181469] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8928.394408] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8932.924473] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8954.328376] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 8973.953802] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 8976.536171] Lustre: Mounted lustre-client [ 8998.707140] LustreError: 189473:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb10811800: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 8998.872199] Lustre: Unmounted lustre-client [ 9133.985958] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9139.098574] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9161.981909] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9210.715568] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 03:59:27 (1775203167) [ 9213.090773] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9215.685635] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 03:59:31 (1775203171) [ 9281.321763] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9286.310767] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9332.225669] Key type lgssc unregistered [ 9332.523488] LNet: 195677:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9332.543164] LNetError: 195677:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9332.571179] LNet: Removed LNI 192.168.206.38@tcp [ 9333.502299] Key type .llcrypt unregistered [ 9333.504699] Key type ._llcrypt unregistered [ 9351.139367] Key type ._llcrypt registered [ 9351.149331] Key type .llcrypt registered [ 9353.915980] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 04:01:49 (1775203309) [ 9412.841587] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9412.885147] alg: No test for adler32 (adler32-zlib) [ 9413.984712] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 9414.310473] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 9416.108582] Key type lgssc registered [ 9417.720558] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9464.530393] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9469.395776] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9503.546231] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9540.063616] Key type lgssc unregistered [ 9540.467475] LNet: 199330:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9540.479558] LNetError: 199330:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9540.500352] LNet: Removed LNI 192.168.206.38@tcp [ 9541.204827] Key type .llcrypt unregistered [ 9541.213575] Key type ._llcrypt unregistered [ 9557.747728] Key type ._llcrypt registered [ 9557.751714] Key type .llcrypt registered [ 9559.001661] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 04:05:15 (1775203515) [ 9561.445017] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9561.470371] alg: No test for adler32 (adler32-zlib) [ 9562.629950] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 9562.877202] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 9564.544876] Key type lgssc registered [ 9566.364545] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9622.206469] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9626.559838] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9648.256705] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9650.856413] Lustre: Mounted lustre-client [ 9666.541828] Lustre: lustre-MDT0000-mdc-ffff8ffb06d51000: Connection to lustre-MDT0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9681.898050] Lustre: lustre-MDT0001-mdc-ffff8ffb06d51000: Connection to lustre-MDT0001 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9698.272560] Lustre: 200319:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775203640/real 1775203640] req@000000007d41b6d1 x1861435807319808/t0(0) o400->MGC192.168.206.138@tcp@192.168.206.138@tcp:26/25 lens 224/224 e 0 to 1 dl 1775203656 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9698.309161] LustreError: MGC192.168.206.138@tcp: Connection to MGS (at 192.168.206.138@tcp) was lost; in progress operations using this service will fail [ 9708.585271] Lustre: Evicted from MGS (at 192.168.206.138@tcp) after server handle changed from 0xf347847cfd772fc0 to 0xf347847cfd774c6f [ 9708.604822] Lustre: MGC192.168.206.138@tcp: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [ 9727.983732] LustreError: lustre-MDT0000-mdc-ffff8ffb06d51000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9728.049199] Lustre: lustre-MDT0000-mdc-ffff8ffb06d51000: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [ 9731.139607] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9732.904147] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9737.276054] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9739.558922] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9742.898456] LustreError: 203761:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb06d51000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9742.975977] Lustre: Unmounted lustre-client [ 9770.285659] Key type lgssc unregistered [ 9770.496666] LNet: 204164:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9770.507602] LNetError: 204164:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9770.530333] LNet: Removed LNI 192.168.206.38@tcp [ 9771.167159] Key type .llcrypt unregistered [ 9771.170070] Key type ._llcrypt unregistered [ 9786.116645] Key type ._llcrypt registered [ 9786.119438] Key type .llcrypt registered [ 9787.613754] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 04:09:04 (1775203744) [ 9790.088266] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9790.122223] alg: No test for adler32 (adler32-zlib) [ 9791.155516] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [ 9791.342086] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [ 9793.023675] Key type lgssc registered [ 9794.354572] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9846.658406] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9851.420387] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9910.569995] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9915.197550] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9953.077417] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9973.894599] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [10017.470961] Key type lgssc unregistered [10017.950055] LNet: 209293:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10017.957374] LNetError: 209293:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10017.969233] LNet: Removed LNI 192.168.206.38@tcp [10019.068623] Key type .llcrypt unregistered [10019.075634] Key type ._llcrypt unregistered [10069.600549] Key type ._llcrypt registered [10069.603079] Key type .llcrypt registered [10071.169797] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 04:13:47 (1775204027) [10114.640809] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10114.666816] alg: No test for adler32 (adler32-zlib) [10115.867597] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [10116.240984] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [10118.023237] Key type lgssc registered [10119.594519] Lustre: Echo OBD driver; http://www.lustre.org/ [10205.969174] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10209.765226] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10231.333085] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10271.608397] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 04:17:08 (1775204228) [10279.670543] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 04:17:16 (1775204236) [10316.178409] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10320.968926] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10342.817827] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10345.685562] Lustre: Mounted lustre-client [10352.699628] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10354.991330] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10356.834500] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10358.462310] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10361.337635] Lustre: lustre-MDT0000-mdc-ffff8ffb05e98000: Connection to lustre-MDT0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [10376.676615] Lustre: 211187:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1775204319/real 1775204319] req@000000009d971f72 x1861436387108608/t0(0) o400->MGC192.168.206.138@tcp@192.168.206.138@tcp:26/25 lens 224/224 e 0 to 1 dl 1775204335 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10376.718523] LustreError: MGC192.168.206.138@tcp: Connection to MGS (at 192.168.206.138@tcp) was lost; in progress operations using this service will fail [10386.923239] Lustre: Evicted from MGS (at 192.168.206.138@tcp) after server handle changed from 0x6478d745c24717ca to 0x6478d745c247193d [10386.942374] Lustre: MGC192.168.206.138@tcp: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [10396.174550] Lustre: lustre-MDT0000-mdc-ffff8ffb05e98000: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [10403.902299] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10406.080532] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10410.136954] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10412.524240] Lustre: lustre-MDT0000-mdc-ffff8ffb05e98000: Connection to lustre-MDT0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [10432.999939] LustreError: MGC192.168.206.138@tcp: Connection to MGS (at 192.168.206.138@tcp) was lost; in progress operations using this service will fail [10433.029603] Lustre: Evicted from MGS (at 192.168.206.138@tcp) after server handle changed from 0x6478d745c247193d to 0x6478d745c2471d50 [10433.043112] Lustre: MGC192.168.206.138@tcp: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [10437.638368] Lustre: lustre-MDT0000-mdc-ffff8ffb05e98000: Connection restored to 192.168.206.138@tcp (at 192.168.206.138@tcp) [10445.743217] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10447.604889] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10451.793088] LustreError: 219475:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb05e98000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10451.857260] Lustre: Unmounted lustre-client [10522.641731] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10526.713780] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10543.762993] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10544.342504] Lustre: Mounted lustre-client [10546.744983] LustreError: 221090:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb08d90800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10546.833310] Lustre: Unmounted lustre-client [10574.067646] Key type lgssc unregistered [10574.350223] LNet: 221495:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10574.357700] LNetError: 221495:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10574.378338] LNet: Removed LNI 192.168.206.38@tcp [10575.136563] Key type .llcrypt unregistered [10575.140583] Key type ._llcrypt unregistered [10590.768177] Key type ._llcrypt registered [10590.771646] Key type .llcrypt registered [10592.361933] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 04:22:28 (1775204548) [10596.926995] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10596.967183] alg: No test for adler32 (adler32-zlib) [10598.190879] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [10598.518930] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [10600.295224] Key type lgssc registered [10601.417744] Lustre: Echo OBD driver; http://www.lustre.org/ [10651.627767] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10655.732900] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10674.363705] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10676.039657] Lustre: Mounted lustre-client [10683.417095] LustreError: 224676:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb08d90000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10683.501027] Lustre: Unmounted lustre-client [10745.633102] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10750.548801] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10770.913357] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10771.608188] Lustre: Mounted lustre-client [10780.705482] LustreError: 226279:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb06304000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10780.798734] Lustre: Unmounted lustre-client [10851.501598] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10855.722631] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10878.380375] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10879.160457] Lustre: Mounted lustre-client [10882.084908] LustreError: 227897:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb10815800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10882.297504] Lustre: Unmounted lustre-client [10909.212913] Key type lgssc unregistered [10909.479671] LNet: 228301:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10909.494767] LNetError: 228301:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10909.523632] LNet: Removed LNI 192.168.206.38@tcp [10910.265974] Key type .llcrypt unregistered [10910.269926] Key type ._llcrypt unregistered [10928.079488] Key type ._llcrypt registered [10928.083654] Key type .llcrypt registered [10929.906520] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 04:28:06 (1775204886) [10934.277820] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10934.296596] alg: No test for adler32 (adler32-zlib) [10935.566214] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [10935.946627] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [10937.695291] Key type lgssc registered [10939.438228] Lustre: Echo OBD driver; http://www.lustre.org/ [10985.056983] Key type lgssc unregistered [10985.337780] LNet: 230626:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10985.355734] LNetError: 230626:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10985.381226] LNet: Removed LNI 192.168.206.38@tcp [10986.102251] Key type .llcrypt unregistered [10986.106104] Key type ._llcrypt unregistered [11018.520715] Key type ._llcrypt registered [11018.527768] Key type .llcrypt registered [11019.092292] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11019.104752] alg: No test for adler32 (adler32-zlib) [11020.293721] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [11020.612969] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [11022.303153] Key type lgssc registered [11023.535476] Lustre: Echo OBD driver; http://www.lustre.org/ [11114.862748] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11118.993400] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11140.802990] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11193.732042] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11196.023504] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 04:32:32 (1775205152) [11227.483640] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11233.219673] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11257.898508] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11278.435992] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [11280.448775] Lustre: Mounted lustre-client [11285.493686] Lustre: lustre-OST0001-osc-ffff8ffb05c64800: Connection to lustre-OST0001 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [11292.609233] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11302.981706] Lustre: Unmounted lustre-client [11337.880361] Key type lgssc unregistered [11338.137390] LNet: 237553:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11338.152897] LNetError: 237553:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11338.185489] LNet: Removed LNI 192.168.206.38@tcp [11338.901118] Key type .llcrypt unregistered [11338.905506] Key type ._llcrypt unregistered [11372.155451] Key type ._llcrypt registered [11372.157852] Key type .llcrypt registered [11373.621239] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 04:35:30 (1775205330) [11388.118500] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11388.151262] alg: No test for adler32 (adler32-zlib) [11389.455740] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [11389.774511] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [11391.479248] Key type lgssc registered [11392.957221] Lustre: Echo OBD driver; http://www.lustre.org/ [11441.233453] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11445.083428] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11469.755561] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 04:37:06 (1775205426) [11505.469428] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11510.408172] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11530.412815] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11533.276302] Lustre: Mounted lustre-client [11548.675672] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11551.209824] Lustre: Unmounted lustre-client [11659.351260] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11663.055801] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11713.275606] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11714.110714] Lustre: Mounted lustre-client [11716.774342] LustreError: 244631:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb06306000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11716.892766] Lustre: Unmounted lustre-client [11744.733510] Key type lgssc unregistered [11745.052866] LNet: 245035:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11745.061131] LNetError: 245035:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11745.093407] LNet: Removed LNI 192.168.206.38@tcp [11746.203950] Key type .llcrypt unregistered [11746.209970] Key type ._llcrypt unregistered [11778.767129] Key type ._llcrypt registered [11778.781203] Key type .llcrypt registered [11779.526296] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11779.552797] alg: No test for adler32 (adler32-zlib) [11780.853690] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [11781.139778] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [11782.951648] Key type lgssc registered [11784.703702] Lustre: Echo OBD driver; http://www.lustre.org/ [11864.943031] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11869.280864] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11891.736798] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11948.785100] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11951.176237] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 04:45:07 (1775205907) [11982.830588] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11987.236079] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12006.528759] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12011.698483] Lustre: Mounted lustre-client [12015.557219] LustreError: 251104:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb05534800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12015.673157] Lustre: Unmounted lustre-client [12043.836630] Key type lgssc unregistered [12044.164438] LNet: 251505:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12044.170402] LNetError: 251505:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12044.198314] LNet: Removed LNI 192.168.206.38@tcp [12045.002196] Key type .llcrypt unregistered [12045.006084] Key type ._llcrypt unregistered [12061.907752] Key type ._llcrypt registered [12061.910470] Key type .llcrypt registered [12063.422890] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12065.506600] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 04:47:02 (1775206022) [12075.319109] Key type .llcrypt unregistered [12075.324617] Key type ._llcrypt unregistered [12084.803383] Key type ._llcrypt registered [12084.812453] Key type .llcrypt registered [12085.310447] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12085.323358] alg: No test for adler32 (adler32-zlib) [12086.416864] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [12086.754081] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [12088.487238] Key type lgssc registered [12089.786569] Lustre: Echo OBD driver; http://www.lustre.org/ [12142.875835] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12158.263445] Lustre: Mounted lustre-client [12161.341148] LustreError: 254538:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb107bb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12161.449940] Lustre: Unmounted lustre-client [12188.800635] Key type lgssc unregistered [12189.331523] LNet: 254942:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12189.342768] LNetError: 254942:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12189.365853] LNet: Removed LNI 192.168.206.38@tcp [12190.283040] Key type .llcrypt unregistered [12190.286846] Key type ._llcrypt unregistered [12208.678203] Key type ._llcrypt registered [12208.679827] Key type .llcrypt registered [12210.586444] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 04:49:26 (1775206166) [12214.172645] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12214.198102] alg: No test for adler32 (adler32-zlib) [12215.370116] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [12215.614225] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [12217.375692] Key type lgssc registered [12219.023548] Lustre: Echo OBD driver; http://www.lustre.org/ [12303.846633] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12339.394886] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12344.405153] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12346.240129] Lustre: Mounted lustre-client [12348.818660] LustreError: 258001:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb07427800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12348.914204] Lustre: Unmounted lustre-client [12369.949126] Key type lgssc unregistered [12370.269591] LNet: 258404:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12370.283226] LNetError: 258404:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12370.318880] LNet: Removed LNI 192.168.206.38@tcp [12371.184798] Key type .llcrypt unregistered [12371.189176] Key type ._llcrypt unregistered [12392.687406] Key type ._llcrypt registered [12392.690596] Key type .llcrypt registered [12394.207360] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 04:52:30 (1775206350) [12397.778471] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12397.822561] alg: No test for adler32 (adler32-zlib) [12398.963065] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [12399.222559] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [12401.023196] Key type lgssc registered [12402.580567] Lustre: Echo OBD driver; http://www.lustre.org/ [12453.754574] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12458.613462] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12478.412643] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12481.238968] Lustre: Mounted lustre-client [12486.634649] Lustre: lustre-MDT0000-mdc-ffff8ffb06b40800: Connection to lustre-MDT0000 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [12492.088332] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12492.112906] LustreError: 261498:0:(file.c:6097:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12492.448637] LustreError: 261517:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb06b40800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12492.458566] LustreError: MGC192.168.206.138@tcp: Connection to MGS (at 192.168.206.138@tcp) was lost; in progress operations using this service will fail [12492.529211] Lustre: Unmounted lustre-client [12515.332970] Key type lgssc unregistered [12515.665566] LNet: 261910:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12515.686880] LNetError: 261910:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12515.726472] LNet: Removed LNI 192.168.206.38@tcp [12516.729781] Key type .llcrypt unregistered [12516.736544] Key type ._llcrypt unregistered [12533.256083] Key type ._llcrypt registered [12533.257755] Key type .llcrypt registered [12534.808635] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 04:54:51 (1775206491) [12537.820488] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12537.834170] alg: No test for adler32 (adler32-zlib) [12539.021420] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [12539.476793] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [12541.271171] Key type lgssc registered [12542.665211] Lustre: Echo OBD driver; http://www.lustre.org/ [12591.940903] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12595.673093] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12615.985276] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12617.757994] Lustre: Mounted lustre-client [12622.840115] Lustre: lustre-MDT0001-mdc-ffff8ffb04f53800: Connection to lustre-MDT0001 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [12624.202764] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12626.329299] LustreError: 265013:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb04f53800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12626.401854] Lustre: Unmounted lustre-client [12645.625587] Key type lgssc unregistered [12645.855416] LNet: 265409:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12645.860439] LNetError: 265409:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12645.879938] LNet: Removed LNI 192.168.206.38@tcp [12646.513256] Key type .llcrypt unregistered [12646.521255] Key type ._llcrypt unregistered [12660.821492] Key type ._llcrypt registered [12660.825101] Key type .llcrypt registered [12662.267741] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 04:56:59 (1775206619) [12679.782605] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12679.832092] alg: No test for adler32 (adler32-zlib) [12681.123919] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [12681.403470] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [12683.135279] Key type lgssc registered [12684.608747] Lustre: Echo OBD driver; http://www.lustre.org/ [12789.978389] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12792.647203] Lustre: Mounted lustre-client [12832.253110] Lustre: lustre-MDT0001-mdc-ffff8ffb05fb9800: Connection to lustre-MDT0001 (at 192.168.206.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [12842.870224] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12853.229661] Lustre: Unmounted lustre-client [12881.546615] Key type lgssc unregistered [12881.883940] LNet: 271171:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12881.900237] LNetError: 271171:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12881.923720] LNet: Removed LNI 192.168.206.38@tcp [12882.787096] Key type .llcrypt unregistered [12882.798282] Key type ._llcrypt unregistered [12904.075282] Key type ._llcrypt registered [12904.077205] Key type .llcrypt registered [12905.804607] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 05:01:02 (1775206862) [12907.571682] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12909.793815] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 05:01:06 (1775206866) [12911.582769] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12913.514652] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 05:01:10 (1775206870) [12915.426571] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12917.718540] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 05:01:14 (1775206874) [12919.359576] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12920.945766] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 05:01:18 (1775206878) [12922.734042] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12925.065313] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 05:01:21 (1775206881) [12935.177611] Key type .llcrypt unregistered [12935.180438] Key type ._llcrypt unregistered [12942.661852] Key type ._llcrypt registered [12942.666419] Key type .llcrypt registered [12943.086916] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12943.108518] alg: No test for adler32 (adler32-zlib) [12944.201350] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [12944.535207] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [12946.303187] Key type lgssc registered [12947.827942] Lustre: Echo OBD driver; http://www.lustre.org/ [13019.061508] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13023.523338] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13044.869860] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13046.665994] Lustre: Mounted lustre-client [13049.367181] LustreError: 276792:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb06ca5800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [13049.446490] Lustre: Unmounted lustre-client [13089.378652] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 05:04:06 (1775207046) [13122.823772] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13127.260289] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13162.115260] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13173.299763] Lustre: Mounted lustre-client [13176.055266] LustreError: 278911:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb05535000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [13176.145896] Lustre: Unmounted lustre-client [13220.006571] LNet: 1 local NIs in recovery (showing 1): 192.168.206.38@tcp [13221.393786] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 05:06:18 (1775207178) [13873.412996] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13878.108619] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13915.902983] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14018.994692] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 05:19:35 (1775207975) [14031.223884] Key type lgssc unregistered [14031.550537] LNet: 284468:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14031.568392] LNetError: 284468:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14031.584646] LNet: Removed LNI 192.168.206.38@tcp [14032.434447] Key type .llcrypt unregistered [14032.436469] Key type ._llcrypt unregistered [14163.926251] Key type ._llcrypt registered [14163.930233] Key type .llcrypt registered [14164.594561] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14164.623947] alg: No test for adler32 (adler32-zlib) [14166.001335] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [14166.331958] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [14168.167491] Key type lgssc registered [14170.169624] Lustre: Echo OBD driver; http://www.lustre.org/ [14259.162877] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14264.410540] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14286.618191] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14320.377852] Key type lgssc unregistered [14320.672577] LNet: 288081:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14320.684026] LNetError: 288081:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14320.714305] LNet: Removed LNI 192.168.206.38@tcp [14321.610664] Key type .llcrypt unregistered [14321.614054] Key type ._llcrypt unregistered [14354.733881] Key type ._llcrypt registered [14354.737250] Key type .llcrypt registered [14355.982650] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 05:25:13 (1775208313) [14377.778431] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14377.807969] alg: No test for adler32 (adler32-zlib) [14378.863418] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [14379.050780] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [14380.703948] Key type lgssc registered [14381.935628] Lustre: Echo OBD driver; http://www.lustre.org/ [14429.577932] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 05:26:26 (1775208386) [14443.569240] Key type lgssc unregistered [14443.881867] LNet: 291636:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14443.890861] LNetError: 291636:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14443.911108] LNet: Removed LNI 192.168.206.38@tcp [14444.665713] Key type .llcrypt unregistered [14444.670409] Key type ._llcrypt unregistered [14457.022402] Key type ._llcrypt registered [14457.028259] Key type .llcrypt registered [14457.485239] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14457.495589] alg: No test for adler32 (adler32-zlib) [14458.571224] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [14458.868113] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [14460.520071] Key type lgssc registered [14461.786886] Lustre: Echo OBD driver; http://www.lustre.org/ [14519.589749] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14523.811926] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14546.400183] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14846.742519] LNet: Added LNI 192.168.206.38@tcp50 [8/256/0/180] [14848.639492] LNet: Removed LNI 192.168.206.38@tcp [14850.773258] Lustre: 295948:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8ffb11c01000: config has no valid NIDs, force dynamic NIDs [14851.981716] Lustre: Mounted lustre-client [14852.042557] LustreError: 295963:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb11c01000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [14852.134392] Lustre: Unmounted lustre-client [14854.396957] Key type lgssc unregistered [14854.652510] LNet: 296214:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14854.659856] LNetError: 296214:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14854.680802] LNet: Removed LNI 192.168.206.38@tcp50 [14855.061327] Key type .llcrypt unregistered [14855.065554] Key type ._llcrypt unregistered [14868.148739] Key type ._llcrypt registered [14868.150586] Key type .llcrypt registered [14868.635872] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14868.659350] alg: No test for adler32 (adler32-zlib) [14869.735885] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [14870.039875] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [14871.703164] Key type lgssc registered [14872.888920] Lustre: Echo OBD driver; http://www.lustre.org/ [14933.523286] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14937.773487] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14945.918820] LNet: Added LNI 192.168.206.38@tcp50 [8/256/0/180] [14946.646378] LNet: Removed LNI 192.168.206.38@tcp [14947.902355] Lustre: 298847:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8ffb0785c000: config has no valid NIDs, force dynamic NIDs [14949.181295] Lustre: Mounted lustre-client [14949.805678] LustreError: 298885:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb0785c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [14949.940405] Lustre: Unmounted lustre-client [14993.146116] Key type lgssc unregistered [14993.469590] LNet: 299726:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14993.486443] LNetError: 299726:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14993.515376] LNet: Removed LNI 192.168.206.38@tcp50 [14994.084549] Key type .llcrypt unregistered [14994.086191] Key type ._llcrypt unregistered [15006.091424] Key type ._llcrypt registered [15006.093550] Key type .llcrypt registered [15007.401081] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 05:36:04 (1775208964) [15009.713607] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15009.790500] alg: No test for adler32 (adler32-zlib) [15010.912664] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [15011.132943] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [15012.815266] Key type lgssc registered [15013.990398] Lustre: Echo OBD driver; http://www.lustre.org/ [15062.522074] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15066.750399] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15086.282274] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15087.934646] Lustre: Mounted lustre-client [15143.169786] Lustre: Mounted fs15246-client [15157.895997] LustreError: 303866:0:(lov_obd.c:786:lov_cleanup()) fs15246-clilov-ffff8ffb05879000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [15157.944212] Lustre: Unmounted fs15246-client [15184.560410] LustreError: 304085:0:(lov_obd.c:786:lov_cleanup()) lustre-clilov-ffff8ffb050fd800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [15184.696172] Lustre: Unmounted lustre-client [15215.206532] Key type lgssc unregistered [15215.644191] LNet: 304489:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15215.655675] LNetError: 304489:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15215.691638] LNet: Removed LNI 192.168.206.38@tcp [15216.699651] Key type .llcrypt unregistered [15216.701819] Key type ._llcrypt unregistered [15231.101694] Key type ._llcrypt registered [15231.104969] Key type .llcrypt registered [15232.750564] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 05:39:49 (1775209189) [15234.212282] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15234.228813] alg: No test for adler32 (adler32-zlib) [15235.265559] Lustre: Lustre: Build Version: 2.17.51_74_g48b5ed2 [15235.458288] LNet: Added LNI 192.168.206.38@tcp [8/256/0/180] [15237.167175] Key type lgssc registered [15238.766873] Lustre: Echo OBD driver; http://www.lustre.org/ [15375.475674] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15379.334361] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15401.365260] Lustre: DEBUG MARKER: oleg638-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15499.210196] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15204 sec ========= 05:44:16 (1775209456) [15500.824571] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 05:44:17 (1775209457) === [15504.038434] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 05:44:21 (1775209461) === [15536.918714] Key type lgssc unregistered [15537.146620] LNet: 313659:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15537.157560] LNetError: 313659:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15537.168421] LNet: Removed LNI 192.168.206.38@tcp [15537.618787] Key type .llcrypt unregistered [15537.622408] Key type ._llcrypt unregistered