[ 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 454495542 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2400.000 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, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.002297] x2apic enabled [ 0.003005] Switched APIC routing to physical x2apic. [ 0.004010] kvm-guest: setup PV IPIs [ 0.006755] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 0.007019] Calibrating delay loop (skipped) preset value.. 4800.00 BogoMIPS (lpj=2400000) [ 0.008006] pid_max: default: 32768 minimum: 301 [ 0.009108] LSM: Security Framework initializing [ 0.010058] Yama: becoming mindful. [ 0.011023] SELinux: Initializing. [ 0.012045] *** VALIDATE selinux *** [ 0.020268] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024476] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025122] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026000] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027081] *** VALIDATE tmpfs *** [ 0.028369] *** VALIDATE proc *** [ 0.029212] *** VALIDATE cgroup *** [ 0.030004] *** VALIDATE cgroup2 *** [ 0.031227] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.032131] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.033005] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.034023] Spectre V2 : User space: Vulnerable [ 0.035004] Speculative Store Bypass: Vulnerable [ 0.038204] debug: unmapping init [mem 0xffffffffacc59000-0xffffffffacc60fff] [ 0.040119] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.041625] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.042012] ... version: 2 [ 0.043014] ... bit width: 48 [ 0.044006] ... generic registers: 4 [ 0.045007] ... value mask: 0000ffffffffffff [ 0.046011] ... max period: 00007fffffffffff [ 0.047016] ... fixed-purpose events: 3 [ 0.048012] ... event mask: 000000070000000f [ 0.049392] rcu: Hierarchical SRCU implementation. [ 0.051378] smp: Bringing up secondary CPUs ... [ 0.052499] x86: Booting SMP configuration: [ 0.053016] .... node #0, CPUs: #1 #2 #3 [ 0.056064] smp: Brought up 1 node, 4 CPUs [ 0.058007] smpboot: Max logical packages: 1 [ 0.059007] smpboot: Total of 4 processors activated (19200.00 BogoMIPS) [ 0.147158] node 0 deferred pages initialised in 86ms [ 0.150306] devtmpfs: initialized [ 0.151228] x86/mm: Memory block size: 128MB [ 0.153803] gcov: version magic: 0x41383552 [ 0.157458] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.158120] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.159297] pinctrl core: initialized pinctrl subsystem [ 0.160312] [ 0.161000] ************************************************************* [ 0.163027] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.166026] ** ** [ 0.168007] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.169005] ** ** [ 0.171008] ** This means that this kernel is built to expose internal ** [ 0.173005] ** IOMMU data structures, which may compromise security on ** [ 0.174004] ** your system. ** [ 0.176007] ** ** [ 0.178007] ** If you see this message and you are not debugging the ** [ 0.180008] ** kernel, report this immediately to your vendor! ** [ 0.182009] ** ** [ 0.184007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.186008] ************************************************************* [ 0.188655] NET: Registered protocol family 16 [ 0.191412] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.193031] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.195027] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.197453] cpuidle: using governor menu [ 0.198559] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.201512] PCI: Using configuration type 1 for base access [ 0.203156] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.212109] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.213030] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.214145] cryptd: max_cpu_qlen set to 1000 [ 0.215235] ACPI: Added _OSI(Module Device) [ 0.216013] ACPI: Added _OSI(Processor Device) [ 0.217032] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.218041] ACPI: Added _OSI(Processor Aggregator Device) [ 0.223857] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.231614] ACPI: Interpreter enabled [ 0.233057] ACPI: PM: (supports S0 S3 S4 S5) [ 0.235017] ACPI: Using IOAPIC for interrupt routing [ 0.237141] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.240406] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.250670] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.253030] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.256016] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.259099] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.264520] acpiphp: Slot [2] registered [ 0.266103] acpiphp: Slot [5] registered [ 0.267114] acpiphp: Slot [6] registered [ 0.269102] acpiphp: Slot [3] registered [ 0.270095] acpiphp: Slot [4] registered [ 0.271067] acpiphp: Slot [7] registered [ 0.273095] acpiphp: Slot [8] registered [ 0.274079] acpiphp: Slot [9] registered [ 0.275059] acpiphp: Slot [10] registered [ 0.277086] acpiphp: Slot [11] registered [ 0.278073] acpiphp: Slot [12] registered [ 0.280065] acpiphp: Slot [13] registered [ 0.281064] acpiphp: Slot [14] registered [ 0.283093] acpiphp: Slot [15] registered [ 0.284073] acpiphp: Slot [16] registered [ 0.286074] acpiphp: Slot [17] registered [ 0.287067] acpiphp: Slot [18] registered [ 0.289066] acpiphp: Slot [19] registered [ 0.290068] acpiphp: Slot [20] registered [ 0.292102] acpiphp: Slot [21] registered [ 0.293082] acpiphp: Slot [22] registered [ 0.295064] acpiphp: Slot [23] registered [ 0.297129] acpiphp: Slot [24] registered [ 0.298127] acpiphp: Slot [25] registered [ 0.299067] acpiphp: Slot [26] registered [ 0.301047] acpiphp: Slot [27] registered [ 0.301993] acpiphp: Slot [28] registered [ 0.302043] acpiphp: Slot [29] registered [ 0.304045] acpiphp: Slot [30] registered [ 0.305107] acpiphp: Slot [31] registered [ 0.306070] PCI host bridge to bus 0000:00 [ 0.307010] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.308008] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.310009] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.311010] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.313012] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.315017] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.317197] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.320000] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.322201] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.328944] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.331992] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.334023] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.336019] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.338024] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.340698] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.343643] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.345025] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.347759] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.350600] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.358017] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.361011] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.366033] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.371008] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.374000] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.384016] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.389923] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.393000] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.396967] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.406928] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.414453] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.416338] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.418333] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.420306] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.422178] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.426133] iommu: Default domain type: Passthrough [ 0.428519] SCSI subsystem initialized [ 0.430244] ACPI: bus type USB registered [ 0.433184] usbcore: registered new interface driver usbfs [ 0.436116] usbcore: registered new interface driver hub [ 0.440137] usbcore: registered new device driver usb [ 0.443156] pps_core: LinuxPPS API ver. 1 registered [ 0.444008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.447047] PTP clock support registered [ 0.449051] EDAC MC: Ver: 3.0.0 [ 0.450226] PCI: Using ACPI for IRQ routing [ 0.452895] NetLabel: Initializing [ 0.454015] NetLabel: domain hash size = 128 [ 0.456008] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.458076] NetLabel: unlabeled traffic allowed by default [ 0.460120] vgaarb: loaded [ 0.462323] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.463011] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.470274] clocksource: Switched to clocksource kvm-clock [ 0.554427] VFS: Disk quotas dquot_6.6.0 [ 0.555941] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.558365] *** VALIDATE ramfs *** [ 0.559578] *** VALIDATE hugetlbfs *** [ 0.561206] pnp: PnP ACPI init [ 0.563692] pnp: PnP ACPI: found 6 devices [ 0.580714] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.584576] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.587053] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.589414] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.591893] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.593965] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.597380] NET: Registered protocol family 2 [ 0.600667] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.606730] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.611114] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.616841] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.620791] TCP: Hash tables configured (established 65536 bind 65536) [ 0.623943] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.627591] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.631128] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.634574] NET: Registered protocol family 1 [ 0.637257] RPC: Registered named UNIX socket transport module. [ 0.639465] RPC: Registered udp transport module. [ 0.641328] RPC: Registered tcp transport module. [ 0.642874] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.645359] NET: Registered protocol family 44 [ 0.647097] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.649513] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.651749] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.654185] PCI: CLS 0 bytes, default 64 [ 0.655858] Unpacking initramfs... [ 2.174284] debug: unmapping init [mem 0xffff88c37cc64000-0xffff88c37ffcffff] [ 2.178183] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.180235] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.183235] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 2.684263] Initialise system trusted keyrings [ 2.686267] Key type blacklist registered [ 2.688523] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.698771] zbud: loaded [ 2.702062] *** VALIDATE nfs *** [ 2.703407] *** VALIDATE nfs4 *** [ 2.705294] pstore: using deflate compression [ 2.709524] Platform Keyring initialized [ 2.829741] NET: Registered protocol family 38 [ 2.832363] Key type asymmetric registered [ 2.834393] Asymmetric key parser 'x509' registered [ 2.838119] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.841859] io scheduler mq-deadline registered [ 2.845462] io scheduler kyber registered [ 2.847402] io scheduler bfq registered [ 2.849679] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.853423] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.856206] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.859687] ACPI: Power Button [PWRF] [ 2.866404] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.874359] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.884356] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.915204] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.947275] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.952963] Non-volatile memory driver v1.3 [ 2.954967] Linux agpgart interface v0.103 [ 2.989622] virtio_blk virtio1: [vda] 140344 512-byte logical blocks (71.9 MB/68.5 MiB) [ 2.993376] vda: detected capacity change from 0 to 71856128 [ 3.011542] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.015680] vdb: detected capacity change from 0 to 1073741824 [ 3.022887] libphy: Fixed MDIO Bus: probed [ 3.029895] usbcore: registered new interface driver usbserial_generic [ 3.033214] usbserial: USB Serial support registered for generic [ 3.035926] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.040897] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.043388] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.046335] mousedev: PS/2 mouse device common for all mice [ 3.049933] rtc_cmos 00:05: RTC can wake from S4 [ 3.053459] rtc_cmos 00:05: registered as rtc0 [ 3.056291] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.059646] intel_pstate: CPU model not supported [ 3.062345] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.063615] hid: raw HID events driver (C) Jiri Kosina [ 3.069775] usbcore: registered new interface driver usbhid [ 3.071955] usbhid: USB HID core driver [ 3.074853] drop_monitor: Initializing network drop monitor service [ 3.078028] Initializing XFRM netlink socket [ 3.082570] NET: Registered protocol family 10 [ 3.084329] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.087595] Segment Routing with IPv6 [ 3.092501] NET: Registered protocol family 17 [ 3.094826] mpls_gso: MPLS GSO support [ 3.097665] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.103033] RAS: Correctable Errors collector initialized. [ 3.105681] AVX version of gcm_enc/dec engaged. [ 3.107859] AES CTR mode by8 optimization enabled [ 3.184503] sched_clock: Marking stable (3184422845, 0)->(3989885454, -805462609) [ 3.191740] registered taskstats version 1 [ 3.193743] Loading compiled-in X.509 certificates [ 3.199502] zswap: loaded using pool lzo/zbud [ 3.229439] Key type big_key registered [ 3.242551] Key type encrypted registered [ 3.244270] ima: No TPM chip found, activating TPM-bypass! [ 3.246473] ima: Allocated hash algorithm: sha1 [ 3.248294] ima: No architecture policies found [ 3.249886] evm: Initialising EVM extended attributes: [ 3.251728] evm: security.selinux [ 3.253088] evm: security.ima [ 3.254273] evm: security.capability [ 3.255489] evm: HMAC attrs: 0x1 [ 3.257805] rtc_cmos 00:05: setting system clock to 2026-04-28 23:59:52 UTC (1777420792) [ 3.264902] debug: unmapping init [mem 0xffffffffadc03000-0xffffffffaddfffff] [ 3.268181] debug: unmapping init [mem 0xffffffffac982000-0xffffffffacc58fff] [ 3.277312] Write protecting the kernel read-only data: 28672k [ 3.279620] debug: unmapping init [mem 0xffffffffab003000-0xffffffffab1fffff] [ 3.281522] debug: unmapping init [mem 0xffffffffab914000-0xffffffffab9fffff] [ 3.304369] 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.309794] systemd[1]: Detected virtualization kvm. [ 3.312357] systemd[1]: Detected architecture x86-64. [ 3.313613] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.335618] systemd[1]: No hostname configured. [ 3.336730] systemd[1]: Set hostname to . [ 3.338096] random: systemd: uninitialized urandom read (16 bytes read) [ 3.339741] systemd[1]: Initializing machine ID from random generator. [ 3.499080] random: systemd: uninitialized urandom read (16 bytes read) [ 3.502081] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 3.507728] random: systemd: uninitialized urandom read (16 bytes read) [ 3.510756] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 3.523728] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Timers. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Swap. Starting Create Volatile Files and Directories... [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Reached target Slices. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Paths. Starting Setup Virtual Console... Starting Apply Kernel Variables... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. 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.473562] device-mapper: uevent: version 1.0.3 [ 4.475752] 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 ] Started udev Coldplug all Devices. [ OK ] Mounted Kernel Configuration File System. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 5.445046] virtio_net virtio0 ens2: renamed from eth0 Starting dracut [ 5.458349] random: fast init done initqueue hook... [ 5.730187] scsi host0: ata_piix [ 5.736454] scsi host1: ata_piix [ 5.742614] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.746751] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 10.766746] random: crng init done [ 10.770649] random: 7 urandom warning(s) missed due to ratelimiting [ 12.059730] dracut-initqueue[577]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 13.277464] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 14.795715] printk: systemd: 25 output lines suppressed due to ratelimiting [ 15.294827] SELinux: Disabled at runtime. [ 15.371909] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 15.382135] systemd[1]: Detected virtualization kvm. [ 15.383821] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 16.446889] systemd[1]: initrd-switch-root.service: Succeeded. [ 16.450453] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 16.463995] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 16.469478] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 16.474538] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 16.485083] systemd[1]: Starting Journal Service... Starting Journal Service... [ 16.494145] systemd[1]: Mounting Kernel Debug File System... Mounting Kernel Debug File System... Mounting Huge Pages File System... Starting Create list of required st…ce nodes for the current kernel... Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ 16.615427] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-getty.slice. [ OK ] Reached target rpc_pipefs.target. Starting Remount Root and Kernel File Systems... Starting Apply Kernel Variables... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. Mounting POSIX Message Queue File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on udev Kernel Socket. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Stopped target Initrd File Systems. [ OK ] Started Journal Service. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ 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 ] Mounted POSIX Message Queue File System. Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 17.305600] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 18.245538] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 18.248076] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 18.711088] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 18.782982] EDAC sbridge: Ver: 1.1.2 [ 20.867372] Key type dns_resolver registered [ 21.237106] NFS: Registering the id_resolver key type [ 21.239130] Key type id_resolver registered [ 21.240631] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Network Manager... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ 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 Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg405-client login: [ 48.454280] libcfs: loading out-of-tree module taints kernel. [ 48.485219] Key type ._llcrypt registered [ 48.486533] Key type .llcrypt registered [ 48.705995] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 48.710644] alg: No test for adler32 (adler32-zlib) [ 49.648249] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 49.887687] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 51.480164] Key type lgssc registered [ 52.066442] Lustre: Echo OBD driver; http://www.lustre.org/ [ 109.070793] Lustre: Mounted lustre-client [ 111.527688] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 125.918779] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing check_logdir /tmp/testlogs/ [ 127.363435] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing yml_node [ 128.610827] Lustre: DEBUG MARKER: Client: 2.17.50.193 [ 129.398533] Lustre: DEBUG MARKER: MDS: 2.17.50.193 [ 130.211102] Lustre: DEBUG MARKER: OSS: 2.17.50.193 [ 130.789658] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Tue Apr 28 20:01:59 EDT 2026 [ 134.624209] Lustre: lustre-OST0000-osc-ffff88c3d155a000: disconnect after 24s idle [ 136.910316] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 137.453191] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 138.117289] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 148.464032] Lustre: Unmounted lustre-client [ 229.717596] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 231.763952] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 243.606840] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 269.001953] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 20:04:17 (1777421057) [ 270.210271] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 271.100695] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 20:04:19 (1777421059) [ 286.319590] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 288.207737] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 297.174365] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 302.614966] Lustre: Mounted lustre-client [ 308.693496] LustreError: 14436:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c8def800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 308.736985] Lustre: Unmounted lustre-client [ 330.638342] Key type lgssc unregistered [ 330.798627] LNet: 14843:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 330.805186] LNetError: 14843:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 330.815417] LNet: Removed LNI 192.168.204.5@tcp [ 331.211362] Key type .llcrypt unregistered [ 331.214112] Key type ._llcrypt unregistered [ 338.675970] Key type ._llcrypt registered [ 338.678040] Key type .llcrypt registered [ 339.306704] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 20:05:27 (1777421127) [ 339.966616] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 339.994374] alg: No test for adler32 (adler32-zlib) [ 340.889234] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 341.035504] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 342.656141] Key type lgssc registered [ 343.262471] Lustre: Echo OBD driver; http://www.lustre.org/ [ 355.676010] hrtimer: interrupt took 3784965 ns [ 390.708777] Lustre: Mounted lustre-client [ 472.772567] LustreError: 18238:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d0afb800: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 472.801406] Lustre: Unmounted lustre-client [ 491.758847] Key type lgssc unregistered [ 491.921369] LNet: 18702:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 491.934174] LNetError: 18702:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 492.968666] LNet: Removed LNI 192.168.204.5@tcp [ 493.399468] Key type .llcrypt unregistered [ 493.402489] Key type ._llcrypt unregistered [ 498.875336] Key type ._llcrypt registered [ 498.877536] Key type .llcrypt registered [ 499.650836] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 20:08:08 (1777421288) [ 500.698804] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 500.710229] alg: No test for adler32 (adler32-zlib) [ 501.599280] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 501.710146] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 503.328217] Key type lgssc registered [ 503.958304] Lustre: Echo OBD driver; http://www.lustre.org/ [ 531.566327] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 533.893231] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 544.727629] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 547.178948] Lustre: Mounted lustre-client [ 556.847695] LustreError: 21808:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d858a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 556.900687] Lustre: Unmounted lustre-client [ 584.292114] Key type lgssc unregistered [ 584.462567] LNet: 22212:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 584.471430] LNetError: 22212:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 584.484799] LNet: Removed LNI 192.168.204.5@tcp [ 584.880087] Key type .llcrypt unregistered [ 584.882115] Key type ._llcrypt unregistered [ 590.279413] Key type ._llcrypt registered [ 590.281378] Key type .llcrypt registered [ 591.084670] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 20:09:39 (1777421379) [ 592.435378] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 592.450560] alg: No test for adler32 (adler32-zlib) [ 593.383552] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 593.543704] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 595.168888] Key type lgssc registered [ 595.952645] Lustre: Echo OBD driver; http://www.lustre.org/ [ 626.348676] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 628.559547] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 639.459853] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 641.822378] Lustre: Mounted lustre-client [ 649.388184] LustreError: 24910:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c38da800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 649.463356] Lustre: Unmounted lustre-client [ 678.198774] Key type lgssc unregistered [ 678.339252] LNet: 25313:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 678.343325] LNetError: 25313:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 678.354330] LNet: Removed LNI 192.168.204.5@tcp [ 678.644331] Key type .llcrypt unregistered [ 678.646080] Key type ._llcrypt unregistered [ 685.510965] Key type ._llcrypt registered [ 685.513702] Key type .llcrypt registered [ 686.211636] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 20:11:14 (1777421474) [ 687.339760] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 687.348613] alg: No test for adler32 (adler32-zlib) [ 688.268604] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 688.394348] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 690.016562] Key type lgssc registered [ 690.595503] Lustre: Echo OBD driver; http://www.lustre.org/ [ 713.564382] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 715.439387] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 724.596351] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 731.144862] Lustre: Mounted lustre-client [ 736.228372] Lustre: lustre-MDT0000-mdc-ffff88c3c7959000: Connection to lustre-MDT0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 746.468482] Lustre: lustre-MDT0001-mdc-ffff88c3c7959000: Connection to lustre-MDT0001 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 749.204550] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 757.728311] Lustre: 26271:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777421530/real 1777421530] req@00000000163fb823 x1863761502672512/t0(0) o400->MGC192.168.204.105@tcp@192.168.204.105@tcp:26/25 lens 224/224 e 0 to 1 dl 1777421546 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 757.748763] LustreError: MGC192.168.204.105@tcp: Connection to MGS (at 192.168.204.105@tcp) was lost; in progress operations using this service will fail [ 759.499807] Lustre: Unmounted lustre-client [ 772.531118] Key type lgssc unregistered [ 772.708792] LNet: 28879:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 772.714860] LNetError: 28879:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 773.734922] LNet: Removed LNI 192.168.204.5@tcp [ 774.098730] Key type .llcrypt unregistered [ 774.102415] Key type ._llcrypt unregistered [ 782.890461] Key type ._llcrypt registered [ 782.892156] Key type .llcrypt registered [ 783.605835] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 20:12:52 (1777421572) [ 784.661733] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 784.674698] alg: No test for adler32 (adler32-zlib) [ 785.580661] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 785.693975] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 787.304181] Key type lgssc registered [ 787.817885] Lustre: Echo OBD driver; http://www.lustre.org/ [ 811.037536] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 812.696659] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 820.049306] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 826.363239] Lustre: Mounted lustre-client [ 831.459643] Lustre: lustre-OST0000-osc-ffff88c3c4ae4800: Connection to lustre-OST0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 835.458404] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 845.760644] Lustre: Unmounted lustre-client [ 863.837746] Key type lgssc unregistered [ 863.979646] LNet: 32415:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 863.985772] LNetError: 32415:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 863.994441] LNet: Removed LNI 192.168.204.5@tcp [ 864.261935] Key type .llcrypt unregistered [ 864.263552] Key type ._llcrypt unregistered [ 870.148346] Key type ._llcrypt registered [ 870.149929] Key type .llcrypt registered [ 870.742543] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 20:14:19 (1777421659) [ 871.708733] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 871.717453] alg: No test for adler32 (adler32-zlib) [ 872.585205] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 872.680148] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 874.272321] Key type lgssc registered [ 874.739880] Lustre: Echo OBD driver; http://www.lustre.org/ [ 895.499368] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 897.068960] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 905.090812] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 915.966138] Lustre: Mounted lustre-client [ 918.019672] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 919.627362] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 930.291331] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-04-2820h15m18s [ 931.135272] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 936.418723] Lustre: lustre-MDT0000-mdc-ffff88c3d07b8800: Connection to lustre-MDT0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 938.937382] LustreError: 36119:0:(lmv_obd.c:1435:lmv_statfs()) lustre-MDT0000-mdc-ffff88c3d07b8800: can't stat MDS #0: rc = -19 [ 939.535438] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 942.498618] LustreError: MGC192.168.204.105@tcp: Connection to MGS (at 192.168.204.105@tcp) was lost; in progress operations using this service will fail [ 942.502216] LustreError: lustre-MDT0000-mdc-ffff88c3d07b8800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 942.512333] Lustre: Evicted from MGS (at 192.168.204.105@tcp) after server handle changed from 0xb1a3ce068c0113e3 to 0xb1a3ce068c01178d [ 942.512802] Lustre: lustre-MDT0000-mdc-ffff88c3d07b8800: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 942.521857] Lustre: Skipped 1 previous similar message [ 945.606273] Lustre: DEBUG MARKER: Wait for df (36119) ... [ 946.279381] Lustre: DEBUG MARKER: done [ 946.773631] LustreError: 36727:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d07b8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 946.804235] Lustre: Unmounted lustre-client [ 965.052363] Key type lgssc unregistered [ 965.186576] LNet: 37129:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 965.190558] LNetError: 37129:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 965.205694] LNet: Removed LNI 192.168.204.5@tcp [ 965.476815] Key type .llcrypt unregistered [ 965.478183] Key type ._llcrypt unregistered [ 978.208662] Key type ._llcrypt registered [ 978.210202] Key type .llcrypt registered [ 978.751278] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 20:16:07 (1777421767) [ 979.700355] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 979.733807] alg: No test for adler32 (adler32-zlib) [ 980.622625] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 980.728666] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 982.336165] Key type lgssc registered [ 982.807170] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1002.717245] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1004.692749] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1020.217661] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1021.693740] Lustre: Mounted lustre-client [ 1025.518789] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-04-2820h16m53s [ 1026.677779] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1032.297788] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1034.833360] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1055.200203] Lustre: 41180:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777421824/real 1777421824] req@00000000d115effa x1863761808857216/t0(0) o101->lustre-MDT0000-mdc-ffff88c3d0aff800@192.168.204.105@tcp:12/10 lens 576/1152 e 0 to 1 dl 1777421844 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1055.228550] Lustre: lustre-MDT0000-mdc-ffff88c3d0aff800: Connection to lustre-MDT0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1055.260690] Lustre: lustre-MDT0000-mdc-ffff88c3d0aff800: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 1076.100748] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1077.978381] Lustre: DEBUG MARKER: done [ 1080.341342] LustreError: 41665:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d0aff800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1080.396697] Lustre: Unmounted lustre-client [ 1102.192658] Key type lgssc unregistered [ 1102.359729] LNet: 42067:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1102.364990] LNetError: 42067:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1102.381168] LNet: Removed LNI 192.168.204.5@tcp [ 1102.678453] Key type .llcrypt unregistered [ 1102.679948] Key type ._llcrypt unregistered [ 1119.428325] Key type ._llcrypt registered [ 1119.430454] Key type .llcrypt registered [ 1120.159209] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 20:18:28 (1777421908) [ 1120.993918] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1121.917226] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 20:18:30 (1777421910) [ 1123.958453] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1123.998405] alg: No test for adler32 (adler32-zlib) [ 1125.020991] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 1125.204915] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 1126.865072] Key type lgssc registered [ 1127.570597] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1144.934372] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 20:18:53 (1777421933) [ 1162.787124] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1164.777790] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1175.610431] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1178.008719] Lustre: Mounted lustre-client [ 1180.419265] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1182.624932] LustreError: 46408:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c6c50000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1182.696160] Lustre: Unmounted lustre-client [ 1190.672167] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1226.989886] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1229.211807] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1229.561865] Lustre: Mounted lustre-client [ 1231.766477] LustreError: 47664:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3e0550800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1231.835045] Lustre: Unmounted lustre-client [ 1283.808273] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1286.475125] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1286.850568] Lustre: Mounted lustre-client [ 1289.294591] LustreError: 48782:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3e0413000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1289.358262] Lustre: Unmounted lustre-client [ 1303.706143] Lustre: DEBUG MARKER: files compared the same [ 1320.232368] Key type lgssc unregistered [ 1320.361458] LNet: 49488:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1320.365383] LNetError: 49488:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1320.375891] LNet: Removed LNI 192.168.204.5@tcp [ 1320.668143] Key type .llcrypt unregistered [ 1320.669769] Key type ._llcrypt unregistered [ 1326.989674] Key type ._llcrypt registered [ 1326.991773] Key type .llcrypt registered [ 1327.664678] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 20:21:56 (1777422116) [ 1328.712420] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1328.762893] alg: No test for adler32 (adler32-zlib) [ 1329.657453] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 1329.773564] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 1331.392575] Key type lgssc registered [ 1332.173985] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1353.356245] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1354.767867] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1362.006775] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1372.655861] Lustre: Mounted lustre-client [ 1374.357288] LustreError: 52578:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c6c57800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1374.387074] Lustre: Unmounted lustre-client [ 1392.892386] Key type lgssc unregistered [ 1393.018950] LNet: 52979:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1393.023797] LNetError: 52979:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1393.033761] LNet: Removed LNI 192.168.204.5@tcp [ 1393.326683] Key type .llcrypt unregistered [ 1393.328371] Key type ._llcrypt unregistered [ 1399.479417] Key type ._llcrypt registered [ 1399.481068] Key type .llcrypt registered [ 1400.061307] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 20:23:08 (1777422188) [ 1400.996779] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1401.005477] alg: No test for adler32 (adler32-zlib) [ 1401.885694] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 1401.982450] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 1403.584354] Key type lgssc registered [ 1404.087557] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1466.266489] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1477.903660] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1479.412592] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1497.611758] Key type lgssc unregistered [ 1497.730647] LNet: 56368:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1497.734758] LNetError: 56368:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1497.745429] LNet: Removed LNI 192.168.204.5@tcp [ 1498.011429] Key type .llcrypt unregistered [ 1498.013278] Key type ._llcrypt unregistered [ 1503.615886] Key type ._llcrypt registered [ 1503.617428] Key type .llcrypt registered [ 1504.185270] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 20:24:52 (1777422292) [ 1505.458123] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1505.466593] alg: No test for adler32 (adler32-zlib) [ 1506.346552] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 1506.444327] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 1508.040161] Key type lgssc registered [ 1508.503735] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1536.110106] Lustre: Mounted lustre-client [ 1541.545879] LustreError: 58849:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3e0554800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1541.579078] Lustre: Unmounted lustre-client [ 1562.590336] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 20:25:51 (1777422351) [ 1604.395846] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1610.273154] Lustre: Mounted lustre-client [ 1615.598538] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1615.600963] LustreError: 62799:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff88c3d0b95800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 1615.608318] Lustre: 57350:0:(llite_lib.c:4190:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.105@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 1625.913707] Lustre: Unmounted lustre-client [ 1653.172589] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 20:27:21 (1777422441) [ 1657.150692] Key type lgssc unregistered [ 1657.272858] LNet: 64008:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1657.275855] LNetError: 64008:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1657.285695] LNet: Removed LNI 192.168.204.5@tcp [ 1657.515327] Key type .llcrypt unregistered [ 1657.516966] Key type ._llcrypt unregistered [ 1661.651993] Key type ._llcrypt registered [ 1661.658144] Key type .llcrypt registered [ 1661.843030] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1661.854529] alg: No test for adler32 (adler32-zlib) [ 1662.715502] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 1662.793186] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 1664.376177] Key type lgssc registered [ 1664.830323] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1684.345490] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1685.624436] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1692.157051] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1702.899201] Lustre: Mounted lustre-client [ 1704.554195] LustreError: 66524:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c4673800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1704.585471] Lustre: Unmounted lustre-client [ 1714.284700] Key type lgssc unregistered [ 1714.398775] LNet: 66926:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1714.402446] LNetError: 66926:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1714.410954] LNet: Removed LNI 192.168.204.5@tcp [ 1714.646719] Key type .llcrypt unregistered [ 1714.647895] Key type ._llcrypt unregistered [ 1718.374209] Key type ._llcrypt registered [ 1718.375237] Key type .llcrypt registered [ 1718.640802] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1718.647712] alg: No test for adler32 (adler32-zlib) [ 1719.509329] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 1719.599566] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 1721.184154] Key type lgssc registered [ 1721.577474] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1771.961496] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1773.275049] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1780.026201] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1790.449694] Lustre: Mounted lustre-client [ 1790.951802] LustreError: 69857:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c80ce800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1790.990183] Lustre: Unmounted lustre-client [ 1809.019709] Key type lgssc unregistered [ 1809.150733] LNet: 70261:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1809.154275] LNetError: 70261:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1809.162839] LNet: Removed LNI 192.168.204.5@tcp [ 1809.430953] Key type .llcrypt unregistered [ 1809.432432] Key type ._llcrypt unregistered [ 1814.910983] Key type ._llcrypt registered [ 1814.912242] Key type .llcrypt registered [ 1815.389407] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 20:30:04 (1777422604) [ 1816.231493] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1816.240369] alg: No test for adler32 (adler32-zlib) [ 1817.116686] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 1817.206640] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 1818.792207] Key type lgssc registered [ 1819.236904] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1839.666762] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1841.249475] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1849.460441] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1855.992173] Lustre: Mounted lustre-client [ 1858.328603] LustreError: 73375:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c795a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1858.382166] Lustre: Unmounted lustre-client [ 1858.575833] Lustre: Mounted lustre-client [ 1859.431670] LustreError: 73453:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d2673000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1859.477191] Lustre: Unmounted lustre-client [ 1885.211371] Key type lgssc unregistered [ 1885.354724] LNet: 73856:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1885.359712] LNetError: 73856:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1885.369841] LNet: Removed LNI 192.168.204.5@tcp [ 1885.668180] Key type .llcrypt unregistered [ 1885.670331] Key type ._llcrypt unregistered [ 1890.140849] Key type ._llcrypt registered [ 1890.142630] Key type .llcrypt registered [ 1890.314365] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1890.321227] alg: No test for adler32 (adler32-zlib) [ 1891.188705] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 1891.280787] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 1892.872117] Key type lgssc registered [ 1893.347480] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1912.936379] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1914.375805] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1921.840101] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1932.277429] Lustre: Mounted lustre-client [ 1934.048760] LustreError: 76392:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c6c55000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1934.083415] Lustre: Unmounted lustre-client [ 1952.154958] Key type lgssc unregistered [ 1952.283726] LNet: 76795:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1952.287460] LNetError: 76795:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1952.302816] LNet: Removed LNI 192.168.204.5@tcp [ 1952.551566] Key type .llcrypt unregistered [ 1952.552986] Key type ._llcrypt unregistered [ 1958.041439] Key type ._llcrypt registered [ 1958.042993] Key type .llcrypt registered [ 1958.507417] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 20:32:27 (1777422747) [ 1959.269276] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1959.311993] alg: No test for adler32 (adler32-zlib) [ 1960.181551] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 1960.268218] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 1961.856197] Key type lgssc registered [ 1962.275716] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1980.469349] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1981.828714] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1988.220594] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1998.837407] Lustre: Mounted lustre-client [ 2004.343506] Lustre: lustre: nosquash_nids is cleared [ 2004.353772] Lustre: lustre: root_squash is set to 500:500 [ 2012.527494] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.5@tcp 192.168.0.[2,10]@tcp [ 2019.631341] Lustre: lustre: nosquash_nids set to 192.168.204.5/24@tcp [ 2027.102231] LustreError: 80288:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d04fd000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2027.137126] Lustre: Unmounted lustre-client [ 2036.529058] Key type lgssc unregistered [ 2036.663772] LNet: 80689:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2036.666810] LNetError: 80689:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2036.675683] LNet: Removed LNI 192.168.204.5@tcp [ 2036.959081] Key type .llcrypt unregistered [ 2036.960505] Key type ._llcrypt unregistered [ 2042.145408] Key type ._llcrypt registered [ 2042.146895] Key type .llcrypt registered [ 2042.622375] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 20:33:51 (1777422831) [ 2043.402539] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 2043.970597] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 20:33:52 (1777422832) [ 2044.775673] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2044.782655] alg: No test for adler32 (adler32-zlib) [ 2045.645756] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 2045.741396] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 2047.328176] Key type lgssc registered [ 2047.750947] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2065.265203] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2066.590300] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2072.782128] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2072.954127] Lustre: lustre: root_squash is set to 500:500 [ 2072.961793] Lustre: lustre: nosquash_nids set to 192.168.204.5/24@tcp [ 2083.312190] Lustre: Mounted lustre-client [ 2085.636859] LustreError: 84149:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d07bc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2085.668535] Lustre: Unmounted lustre-client [ 2094.803422] Key type lgssc unregistered [ 2094.924510] LNet: 84550:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2094.927297] LNetError: 84550:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2094.935675] LNet: Removed LNI 192.168.204.5@tcp [ 2095.172622] Key type .llcrypt unregistered [ 2095.173984] Key type ._llcrypt unregistered [ 2100.072689] Key type ._llcrypt registered [ 2100.073752] Key type .llcrypt registered [ 2100.499644] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 2100.987533] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 20:34:49 (1777422889) [ 2106.559511] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2106.565849] alg: No test for adler32 (adler32-zlib) [ 2107.426283] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 2107.505191] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 2109.080158] Key type lgssc registered [ 2109.429903] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2137.953514] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2139.173345] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2146.768458] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2176.232058] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2177.441348] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2183.550869] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2196.956533] Lustre: Mounted lustre-client [ 2210.968434] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff88c3d0aff800.ost_server_uuid 50 [ 2211.512984] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff88c3d0aff800.ost_server_uuid in FULL state after 0 sec [ 2211.657317] Lustre: Mounted lustre-client [ 2212.537876] LustreError: 91437:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d858c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2212.583206] Lustre: Unmounted lustre-client [ 2248.735725] Key type lgssc unregistered [ 2248.857534] LNet: 92011:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2248.860607] LNetError: 92011:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2248.867664] LNet: Removed LNI 192.168.204.5@tcp [ 2249.101965] Key type .llcrypt unregistered [ 2249.102969] Key type ._llcrypt unregistered [ 2259.311349] Key type ._llcrypt registered [ 2259.312702] Key type .llcrypt registered [ 2259.783924] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 20:37:28 (1777423048) [ 2265.132205] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2265.183444] alg: No test for adler32 (adler32-zlib) [ 2266.025172] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 2266.106325] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 2267.688142] Key type lgssc registered [ 2268.004697] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2295.247733] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2296.368570] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2303.799243] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2310.105021] Lustre: Mounted lustre-client [ 2325.475746] Lustre: lustre-OST0000-osc-ffff88c3c8b19800: Connection to lustre-OST0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2330.595134] Lustre: lustre-MDT0000-mdc-ffff88c3c8b19800: Connection to lustre-MDT0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2331.616098] Lustre: 93371:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777423104/real 1777423104] req@00000000e1e0b339 x1863763157325568/t0(0) o400->lustre-OST0000-osc-ffff88c3c8b19800@192.168.204.105@tcp:28/4 lens 224/224 e 0 to 1 dl 1777423120 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2336.736165] Lustre: 93371:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1777423109/real 1777423109] req@000000006e9bf650 x1863763157326080/t0(0) o400->lustre-OST0000-osc-ffff88c3c8b19800@192.168.204.105@tcp:28/4 lens 224/224 e 0 to 1 dl 1777423125 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2340.834479] LustreError: MGC192.168.204.105@tcp: Connection to MGS (at 192.168.204.105@tcp) was lost; in progress operations using this service will fail [ 2340.839870] Lustre: 96446:0:(mgc_request.c:1911:mgc_process_log()) MGC192.168.204.105@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 2340.844868] Lustre: Evicted from MGS (at 192.168.204.105@tcp) after server handle changed from 0xffb3e55d721894ae to 0xffb3e55d7218975c [ 2340.849455] Lustre: MGC192.168.204.105@tcp: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 2346.263402] Lustre: lustre-MDT0000-mdc-ffff88c3c8b19800: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 2346.267301] Lustre: Skipped 1 previous similar message [ 2346.646094] LustreError: 97170:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c8b19800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2346.674254] Lustre: Unmounted lustre-client [ 2363.976710] Key type lgssc unregistered [ 2364.102423] LNet: 97572:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2364.105176] LNetError: 97572:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2364.114334] LNet: Removed LNI 192.168.204.5@tcp [ 2364.348435] Key type .llcrypt unregistered [ 2364.349720] Key type ._llcrypt unregistered [ 2369.628379] Key type ._llcrypt registered [ 2369.629661] Key type .llcrypt registered [ 2370.096258] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 20:39:18 (1777423158) [ 2381.747417] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2381.762911] alg: No test for adler32 (adler32-zlib) [ 2382.631327] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 2382.719779] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 2384.296166] Key type lgssc registered [ 2384.671975] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2398.953773] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2449.638643] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2453.075744] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2467.979829] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2475.507461] Lustre: Mounted lustre-client [ 2476.489647] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 2477.266320] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 20:41:05 (1777423265) [ 2584.792843] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2595.075123] Lustre: Unmounted lustre-client [ 2668.318342] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2670.010227] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2680.682463] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2703.316034] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 20:44:51 (1777423491) [ 2742.979186] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2744.713578] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2754.359754] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2754.606471] Lustre: Mounted lustre-client [ 2756.142108] LustreError: 115728:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d0546000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2756.200226] Lustre: Unmounted lustre-client [ 2769.294914] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 20:45:57 (1777423557) [ 2810.494633] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2812.155144] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2821.821873] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2822.069828] Lustre: Mounted lustre-client [ 2823.574068] LustreError: 119769:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c4353800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2823.617530] Lustre: Unmounted lustre-client [ 2843.072770] Key type lgssc unregistered [ 2843.217853] LNet: 120172:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2843.221627] LNetError: 120172:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2843.232767] LNet: Removed LNI 192.168.204.5@tcp [ 2843.564285] Key type .llcrypt unregistered [ 2843.565805] Key type ._llcrypt unregistered [ 2850.786934] Key type ._llcrypt registered [ 2850.789076] Key type .llcrypt registered [ 2851.476314] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 20:47:19 (1777423639) [ 2852.494794] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2852.509968] alg: No test for adler32 (adler32-zlib) [ 2853.403156] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 2853.522660] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 2855.128157] Key type lgssc registered [ 2855.644504] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2877.525635] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2879.415932] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2887.564801] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2894.357535] Lustre: Mounted lustre-client [ 2905.464239] LustreError: 123275:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d0b95800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2905.504127] Lustre: Unmounted lustre-client [ 2924.687072] Key type lgssc unregistered [ 2924.827458] LNet: 123678:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2924.831157] LNetError: 123678:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2924.842580] LNet: Removed LNI 192.168.204.5@tcp [ 2925.174643] Key type .llcrypt unregistered [ 2925.177664] Key type ._llcrypt unregistered [ 2932.193086] Key type ._llcrypt registered [ 2932.195561] Key type .llcrypt registered [ 2932.853465] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 20:48:41 (1777423721) [ 2933.872366] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2933.922570] alg: No test for adler32 (adler32-zlib) [ 2934.880570] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 2934.990109] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 2936.608173] Key type lgssc registered [ 2937.149950] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2959.317872] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2960.975360] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2969.701345] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2975.239573] Lustre: Mounted lustre-client [ 2980.326385] Lustre: lustre-OST0000-osc-ffff88c3c77a0000: Connection to lustre-OST0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2986.393916] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff88c3c77a0000.ost_server_uuid 50 [ 2987.198585] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 2996.741189] LustreError: 127211:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c77a0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2996.782766] Lustre: Unmounted lustre-client [ 3009.399195] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 20:49:57 (1777423797) [ 3022.437600] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3024.081599] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3032.516653] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3041.929995] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3042.175615] Lustre: Mounted lustre-client [ 3047.397930] Lustre: lustre-OST0000-osc-ffff88c3d155e800: Connection to lustre-OST0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3063.055690] LustreError: 129860:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d155e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3063.106182] Lustre: Unmounted lustre-client [ 3092.930333] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 20:51:21 (1777423881) [ 3105.855474] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3107.305587] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3115.114693] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3122.910750] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3123.188033] Lustre: Mounted lustre-client [ 3128.295686] Lustre: lustre-OST0000-osc-ffff88c3c55bb000: Connection to lustre-OST0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3140.680714] LustreError: 132614:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c55bb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3140.685524] LustreError: 132614:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 3140.737537] Lustre: Unmounted lustre-client [ 3168.418106] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 20:52:37 (1777423957) [ 3208.001543] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3209.510441] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3218.695326] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3261.645910] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3263.108305] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3270.530419] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3289.582288] Lustre: Mounted lustre-client [ 3318.609258] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3319.301720] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3319.849281] LustreError: 139198:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c5dd0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3319.856018] LustreError: 139198:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 3319.894165] Lustre: Unmounted lustre-client [ 3339.765542] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 20:55:28 (1777424128) [ 3352.435828] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3353.782934] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3361.253581] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3378.869526] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3396.475749] Lustre: Mounted lustre-client [ 3424.945927] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3425.595586] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3427.301382] Lustre: lustre-OST0001-osc-ffff88c3e0482000: Connection to lustre-OST0001 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3429.448453] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3439.747275] Lustre: Unmounted lustre-client [ 3470.371379] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 20:57:39 (1777424259) [ 3480.423192] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3481.610995] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3487.793145] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3493.370582] Lustre: Mounted lustre-client [ 3501.165764] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3505.866625] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 4 sec [ 3510.237092] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff88c3c54a6800.ost_server_uuid 50 [ 3510.832170] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff88c3c54a6800.ost_server_uuid in FULL state after 0 sec [ 3511.533898] LustreError: 146218:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c54a6800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3511.578601] Lustre: Unmounted lustre-client [ 3511.698468] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3511.701472] Lustre: Skipped 3 previous similar messages [ 3511.743942] Lustre: Mounted lustre-client [ 3512.175540] LustreError: 146281:0:(sec.c:410:import_sec_validate_get()) import 00000000f4b683a9 (NEW) with no sec [ 3544.765470] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 20:58:53 (1777424333) [ 3555.691182] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3556.994509] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3563.442222] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3569.917493] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3570.050688] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 3570.095037] Lustre: Mounted lustre-client [ 3579.896177] LustreError: 149131:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3e0484800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3579.901461] LustreError: 149131:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 3579.941720] Lustre: Unmounted lustre-client [ 3579.943358] Lustre: Skipped 1 previous similar message [ 3613.258110] Key type lgssc unregistered [ 3613.373600] LNet: 149579:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3613.376585] LNetError: 149579:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3613.387756] LNet: Removed LNI 192.168.204.5@tcp [ 3613.636791] Key type .llcrypt unregistered [ 3613.638186] Key type ._llcrypt unregistered [ 3619.020471] Key type ._llcrypt registered [ 3619.022081] Key type .llcrypt registered [ 3619.530883] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 21:00:08 (1777424408) [ 3619.940144] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3619.948350] alg: No test for adler32 (adler32-zlib) [ 3620.820939] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 3620.919325] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 3622.512171] Key type lgssc registered [ 3622.969120] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3642.546824] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3643.756830] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3650.214648] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3656.479128] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3656.625758] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3661.809957] Lustre: Mounted lustre-client [ 3665.261370] LustreError: lustre-MDT0001-mdc-ffff88c3e0483000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 3665.267831] Lustre: lustre-MDT0001-mdc-ffff88c3e0483000: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 3666.503824] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3667.048220] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 3673.705092] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3680.031710] LustreError: 153781:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3e0483000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3680.058393] Lustre: Unmounted lustre-client [ 3699.231179] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 21:01:28 (1777424488) [ 3730.107482] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3731.416891] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3739.184436] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3739.369348] Lustre: Mounted lustre-client [ 3749.368388] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3749.891757] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3764.707909] Lustre: lustre-OST0001-osc-ffff88c3d1246800: Connection to lustre-OST0001 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3767.870249] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3778.171473] Lustre: Unmounted lustre-client [ 3817.950793] Key type lgssc unregistered [ 3818.063553] LNet: 158909:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3818.066648] LNetError: 158909:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3818.075603] LNet: Removed LNI 192.168.204.5@tcp [ 3818.304741] Key type .llcrypt unregistered [ 3818.305954] Key type ._llcrypt unregistered [ 3828.625903] Key type ._llcrypt registered [ 3828.627374] Key type .llcrypt registered [ 3829.063505] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 21:03:37 (1777424617) [ 3829.832495] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3829.843155] alg: No test for adler32 (adler32-zlib) [ 3830.701823] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 3830.781110] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 3832.360178] Key type lgssc registered [ 3832.755773] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3850.855897] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3852.070446] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3858.158845] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3864.539705] Lustre: Mounted lustre-client [ 3901.740710] LustreError: 162176:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3cbb98000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3901.777047] Lustre: Unmounted lustre-client [ 3918.168851] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3918.307980] Lustre: Mounted lustre-client [ 3950.423291] LustreError: 162829:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c77a1800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3950.459117] Lustre: Unmounted lustre-client [ 3968.017403] Key type lgssc unregistered [ 3968.137401] LNet: 163236:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3968.140213] LNetError: 163236:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3968.149436] LNet: Removed LNI 192.168.204.5@tcp [ 3968.382122] Key type .llcrypt unregistered [ 3968.383324] Key type ._llcrypt unregistered [ 3973.411776] Key type ._llcrypt registered [ 3973.412685] Key type .llcrypt registered [ 3973.888405] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 21:06:02 (1777424762) [ 3974.746715] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3974.761438] alg: No test for adler32 (adler32-zlib) [ 3975.612070] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 3975.703382] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 3977.288205] Key type lgssc registered [ 3977.709294] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3995.825044] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3997.343481] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4003.773131] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4015.090210] Lustre: Mounted lustre-client [ 4022.381785] LustreError: 166509:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d1559800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4022.412161] Lustre: Unmounted lustre-client [ 4039.963509] Key type lgssc unregistered [ 4040.086598] LNet: 166912:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4040.089383] LNetError: 166912:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4040.097726] LNet: Removed LNI 192.168.204.5@tcp [ 4040.363190] Key type .llcrypt unregistered [ 4040.364398] Key type ._llcrypt unregistered [ 4044.727130] Key type ._llcrypt registered [ 4044.729824] Key type .llcrypt registered [ 4044.910201] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4044.918907] alg: No test for adler32 (adler32-zlib) [ 4045.784109] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 4045.876101] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 4047.464151] Key type lgssc registered [ 4047.813303] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4065.476090] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4066.825436] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4073.055209] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4083.696384] Lustre: Mounted lustre-client [ 4086.566413] LustreError: 169480:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c46a0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4086.608371] Lustre: Unmounted lustre-client [ 4095.762198] Key type lgssc unregistered [ 4095.878531] LNet: 169882:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4095.881363] LNetError: 169882:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4095.891724] LNet: Removed LNI 192.168.204.5@tcp [ 4096.131910] Key type .llcrypt unregistered [ 4096.133046] Key type ._llcrypt unregistered [ 4101.173973] Key type ._llcrypt registered [ 4101.176620] Key type .llcrypt registered [ 4101.610899] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 21:08:10 (1777424890) [ 4102.343657] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4102.353216] alg: No test for adler32 (adler32-zlib) [ 4103.200577] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 4103.275185] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 4104.856169] Key type lgssc registered [ 4105.203282] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4121.485510] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4122.567223] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4128.207283] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4129.373772] Lustre: Mounted lustre-client [ 4135.614084] LustreError: 173133:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3e1274800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4135.642789] Lustre: Unmounted lustre-client [ 4152.541218] Key type lgssc unregistered [ 4152.658515] LNet: 173536:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4152.661578] LNetError: 173536:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4152.672691] LNet: Removed LNI 192.168.204.5@tcp [ 4152.883140] Key type .llcrypt unregistered [ 4152.884877] Key type ._llcrypt unregistered [ 4156.638369] Key type ._llcrypt registered [ 4156.642516] Key type .llcrypt registered [ 4156.793909] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4156.801081] alg: No test for adler32 (adler32-zlib) [ 4157.646116] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 4157.728140] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 4159.304124] Key type lgssc registered [ 4159.658322] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4176.020492] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4177.163867] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4182.872351] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4198.383853] Lustre: Mounted lustre-client [ 4201.395500] LustreError: 176103:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c5497000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4201.427177] Lustre: Unmounted lustre-client [ 4218.581920] Key type lgssc unregistered [ 4218.699489] LNet: 176505:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4218.703510] LNetError: 176505:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4218.712530] LNet: Removed LNI 192.168.204.5@tcp [ 4218.945915] Key type .llcrypt unregistered [ 4218.947105] Key type ._llcrypt unregistered [ 4224.284164] Key type ._llcrypt registered [ 4224.285688] Key type .llcrypt registered [ 4224.819171] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 21:10:13 (1777425013) [ 4231.803512] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4231.843082] alg: No test for adler32 (adler32-zlib) [ 4232.702177] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 4232.786552] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 4234.368155] Key type lgssc registered [ 4234.748167] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4261.969954] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4263.132373] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4270.088597] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4286.688632] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 21:11:15 (1777425075) [ 4296.037285] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4297.273887] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4303.489264] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4314.097621] Lustre: Mounted lustre-client [ 4315.978434] LustreError: 183004:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d0b91000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4316.011244] Lustre: Unmounted lustre-client [ 4341.300288] Key type lgssc unregistered [ 4341.407444] LNet: 183408:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4341.410304] LNetError: 183408:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4341.417689] LNet: Removed LNI 192.168.204.5@tcp [ 4341.625523] Key type .llcrypt unregistered [ 4341.626808] Key type ._llcrypt unregistered [ 4346.201310] Key type ._llcrypt registered [ 4346.202375] Key type .llcrypt registered [ 4346.609504] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 4347.082634] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 21:12:15 (1777425135) [ 4352.538482] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4352.552194] alg: No test for adler32 (adler32-zlib) [ 4353.414831] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 4353.492093] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 4355.072098] Key type lgssc registered [ 4355.467610] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4385.319390] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4386.415751] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4393.452572] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 4399.017475] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 4401.206427] Lustre: Mounted lustre-client [ 4406.881056] LustreError: 188940:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c5dd5000: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 4406.919105] Lustre: Unmounted lustre-client [ 4465.335907] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4466.493454] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4473.218466] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4494.079645] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 21:14:42 (1777425282) [ 4494.587768] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 4495.151558] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 21:14:43 (1777425283) [ 4512.028932] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4513.178350] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4537.748245] Key type lgssc unregistered [ 4537.876588] LNet: 195104:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4537.880065] LNetError: 195104:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4537.887952] LNet: Removed LNI 192.168.204.5@tcp [ 4538.132761] Key type .llcrypt unregistered [ 4538.134147] Key type ._llcrypt unregistered [ 4543.154409] Key type ._llcrypt registered [ 4543.155651] Key type .llcrypt registered [ 4543.639316] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 21:15:32 (1777425332) [ 4576.783971] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4576.811091] alg: No test for adler32 (adler32-zlib) [ 4577.671686] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 4577.765780] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 4579.344206] Key type lgssc registered [ 4579.729701] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4593.496357] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4594.712935] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4611.492131] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4630.579687] Key type lgssc unregistered [ 4630.687326] LNet: 198737:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4630.690202] LNetError: 198737:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4630.697254] LNet: Removed LNI 192.168.204.5@tcp [ 4630.922483] Key type .llcrypt unregistered [ 4630.923539] Key type ._llcrypt unregistered [ 4635.700131] Key type ._llcrypt registered [ 4635.700988] Key type .llcrypt registered [ 4636.131453] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 21:17:04 (1777425424) [ 4636.871649] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4636.901075] alg: No test for adler32 (adler32-zlib) [ 4637.754535] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 4637.834226] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 4639.416191] Key type lgssc registered [ 4639.789670] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4655.727978] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4656.830544] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4662.768491] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4663.917685] Lustre: Mounted lustre-client [ 4669.411844] Lustre: lustre-MDT0000-mdc-ffff88c3d0b97800: Connection to lustre-MDT0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4674.529955] Lustre: lustre-MDT0001-mdc-ffff88c3d0b97800: Connection to lustre-MDT0001 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4684.770069] LustreError: MGC192.168.204.105@tcp: Connection to MGS (at 192.168.204.105@tcp) was lost; in progress operations using this service will fail [ 4684.776076] Lustre: Evicted from MGS (at 192.168.204.105@tcp) after server handle changed from 0xc0eb245f604aaa12 to 0xc0eb245f604ac372 [ 4684.780778] Lustre: MGC192.168.204.105@tcp: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 4704.227264] LustreError: lustre-MDT0000-mdc-ffff88c3d0b97800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 4704.249148] Lustre: lustre-MDT0000-mdc-ffff88c3d0b97800: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 4705.723993] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4706.240215] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4707.403820] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4715.062051] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 7 sec [ 4715.629634] LustreError: 203190:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d0b97800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4715.657175] Lustre: Unmounted lustre-client [ 4740.704934] Key type lgssc unregistered [ 4740.809496] LNet: 203594:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4740.811802] LNetError: 203594:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4740.824565] LNet: Removed LNI 192.168.204.5@tcp [ 4741.042689] Key type .llcrypt unregistered [ 4741.043736] Key type ._llcrypt unregistered [ 4745.849844] Key type ._llcrypt registered [ 4745.851349] Key type .llcrypt registered [ 4746.324683] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 21:18:55 (1777425535) [ 4747.083230] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4747.132114] alg: No test for adler32 (adler32-zlib) [ 4747.987378] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 4748.077744] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 4749.656153] Key type lgssc registered [ 4750.011406] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4766.110025] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4767.261060] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4787.032204] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4788.167080] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4796.848423] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4802.989760] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4838.598747] Key type lgssc unregistered [ 4838.714300] LNet: 208693:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4838.716439] LNetError: 208693:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4838.723268] LNet: Removed LNI 192.168.204.5@tcp [ 4838.942597] Key type .llcrypt unregistered [ 4838.943634] Key type ._llcrypt unregistered [ 4859.704923] Key type ._llcrypt registered [ 4859.706078] Key type .llcrypt registered [ 4860.184231] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 21:20:48 (1777425648) [ 4872.259110] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4872.267690] alg: No test for adler32 (adler32-zlib) [ 4873.135780] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 4873.232803] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 4874.824149] Key type lgssc registered [ 4875.230959] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4903.532283] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4904.617630] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4911.540713] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4932.980699] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 21:22:01 (1777425721) [ 4935.452915] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 21:22:04 (1777425724) [ 4944.996885] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4946.122618] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4952.317345] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4967.918683] Lustre: Mounted lustre-client [ 4970.978133] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 4971.643192] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 4972.155382] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 4972.654106] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 4978.146827] Lustre: lustre-MDT0000-mdc-ffff88c3c5b7f800: Connection to lustre-MDT0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4988.386118] LustreError: MGC192.168.204.105@tcp: Connection to MGS (at 192.168.204.105@tcp) was lost; in progress operations using this service will fail [ 4988.393092] Lustre: Evicted from MGS (at 192.168.204.105@tcp) after server handle changed from 0xdb7d7a4cbc3bd3e2 to 0xdb7d7a4cbc3bd67b [ 4988.396317] Lustre: MGC192.168.204.105@tcp: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 4991.249555] Lustre: lustre-MDT0000-mdc-ffff88c3c5b7f800: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 4992.380823] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4992.915019] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4994.761534] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 4998.626858] Lustre: lustre-MDT0000-mdc-ffff88c3c5b7f800: Connection to lustre-MDT0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5008.869959] LustreError: MGC192.168.204.105@tcp: Connection to MGS (at 192.168.204.105@tcp) was lost; in progress operations using this service will fail [ 5008.876513] Lustre: Evicted from MGS (at 192.168.204.105@tcp) after server handle changed from 0xdb7d7a4cbc3bd67b to 0xdb7d7a4cbc3bd98b [ 5008.881271] Lustre: MGC192.168.204.105@tcp: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 5013.780180] Lustre: lustre-MDT0000-mdc-ffff88c3c5b7f800: Connection restored to 192.168.204.105@tcp (at 192.168.204.105@tcp) [ 5014.895981] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5015.399077] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5016.958281] LustreError: 218820:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c5b7f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5016.986775] Lustre: Unmounted lustre-client [ 5048.426220] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5049.651827] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5055.924254] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5066.739952] Lustre: Mounted lustre-client [ 5067.094197] LustreError: 220432:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c757a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5067.128260] Lustre: Unmounted lustre-client [ 5084.368269] Key type lgssc unregistered [ 5084.479466] LNet: 220834:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5084.482040] LNetError: 220834:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5084.488629] LNet: Removed LNI 192.168.204.5@tcp [ 5084.719658] Key type .llcrypt unregistered [ 5084.720911] Key type ._llcrypt unregistered [ 5089.829360] Key type ._llcrypt registered [ 5089.830417] Key type .llcrypt registered [ 5090.276234] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 21:24:39 (1777425879) [ 5091.653541] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5091.663831] alg: No test for adler32 (adler32-zlib) [ 5092.519202] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 5092.596918] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 5094.176131] Key type lgssc registered [ 5094.517996] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5111.191178] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5112.419658] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5118.608126] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5134.321418] Lustre: Mounted lustre-client [ 5137.292933] LustreError: 224003:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d155c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5137.326129] Lustre: Unmounted lustre-client [ 5169.519847] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5170.766114] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5176.799064] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5187.573196] Lustre: Mounted lustre-client [ 5193.646200] LustreError: 225598:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c74a0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5193.674121] Lustre: Unmounted lustre-client [ 5225.187080] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5226.366768] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5232.210285] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5247.985941] Lustre: Mounted lustre-client [ 5248.308833] LustreError: 227212:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d0b80800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5248.335507] Lustre: Unmounted lustre-client [ 5265.388380] Key type lgssc unregistered [ 5265.493506] LNet: 227615:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5265.496251] LNetError: 227615:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5265.503610] LNet: Removed LNI 192.168.204.5@tcp [ 5265.704523] Key type .llcrypt unregistered [ 5265.705670] Key type ._llcrypt unregistered [ 5270.271281] Key type ._llcrypt registered [ 5270.272911] Key type .llcrypt registered [ 5270.767272] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 21:27:39 (1777426059) [ 5271.808685] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5271.814797] alg: No test for adler32 (adler32-zlib) [ 5272.663743] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 5272.735934] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 5274.312109] Key type lgssc registered [ 5274.656214] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5290.183830] Key type lgssc unregistered [ 5290.293449] LNet: 229929:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5290.297197] LNetError: 229929:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5290.309345] LNet: Removed LNI 192.168.204.5@tcp [ 5290.547365] Key type .llcrypt unregistered [ 5290.548759] Key type ._llcrypt unregistered [ 5300.161315] Key type ._llcrypt registered [ 5300.162374] Key type .llcrypt registered [ 5300.325373] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5300.331697] alg: No test for adler32 (adler32-zlib) [ 5301.193824] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 5301.269685] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 5302.848119] Key type lgssc registered [ 5303.223592] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5331.267989] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5332.503346] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5339.944421] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5361.672371] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 5362.148335] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 21:29:10 (1777426150) [ 5371.490266] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5372.611122] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5378.298620] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5385.263381] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5386.432140] Lustre: Mounted lustre-client [ 5391.844559] Lustre: lustre-OST0001-osc-ffff88c3d155c000: Connection to lustre-OST0001 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5394.054286] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5404.348056] Lustre: Unmounted lustre-client [ 5436.246474] Key type lgssc unregistered [ 5436.363506] LNet: 236817:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5436.365784] LNetError: 236817:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5436.373748] LNet: Removed LNI 192.168.204.5@tcp [ 5436.609223] Key type .llcrypt unregistered [ 5436.610509] Key type ._llcrypt unregistered [ 5446.025449] Key type ._llcrypt registered [ 5446.026432] Key type .llcrypt registered [ 5446.454690] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 21:30:35 (1777426235) [ 5450.416879] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5450.470167] alg: No test for adler32 (adler32-zlib) [ 5451.325883] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 5451.410443] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 5453.000196] Key type lgssc registered [ 5453.408804] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5469.776353] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5470.809997] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5481.964700] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 21:31:10 (1777426270) [ 5490.885777] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5491.910558] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5497.716088] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5509.081476] Lustre: Mounted lustre-client [ 5513.382967] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5520.337108] Lustre: Unmounted lustre-client [ 5568.176319] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5569.303147] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5605.326528] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5615.602495] Lustre: Mounted lustre-client [ 5616.008217] LustreError: 243939:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d0b87000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5616.039390] Lustre: Unmounted lustre-client [ 5641.444619] Key type lgssc unregistered [ 5641.564500] LNet: 244343:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5641.567711] LNetError: 244343:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5641.578837] LNet: Removed LNI 192.168.204.5@tcp [ 5641.805519] Key type .llcrypt unregistered [ 5641.807374] Key type ._llcrypt unregistered [ 5650.680905] Key type ._llcrypt registered [ 5650.684583] Key type .llcrypt registered [ 5650.855528] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5650.861395] alg: No test for adler32 (adler32-zlib) [ 5651.715161] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 5651.794209] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 5653.376154] Key type lgssc registered [ 5653.730505] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5680.913400] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5682.114032] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5689.142758] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5712.022465] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 5712.563838] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 21:35:01 (1777426501) [ 5722.328974] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5723.436302] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5728.938982] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5740.527672] Lustre: Mounted lustre-client [ 5741.361445] LustreError: 250381:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c96b6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5741.390965] Lustre: Unmounted lustre-client [ 5758.709744] Key type lgssc unregistered [ 5758.828721] LNet: 250783:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5758.831722] LNetError: 250783:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5758.844825] LNet: Removed LNI 192.168.204.5@tcp [ 5759.116911] Key type .llcrypt unregistered [ 5759.118583] Key type ._llcrypt unregistered [ 5763.981881] Key type ._llcrypt registered [ 5763.983201] Key type .llcrypt registered [ 5764.452904] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 5764.976863] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 21:35:53 (1777426553) [ 5767.794206] Key type .llcrypt unregistered [ 5767.795333] Key type ._llcrypt unregistered [ 5770.341123] Key type ._llcrypt registered [ 5770.342165] Key type .llcrypt registered [ 5770.506718] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5770.511761] alg: No test for adler32 (adler32-zlib) [ 5771.358119] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 5771.433514] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 5773.016130] Key type lgssc registered [ 5773.373265] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5790.437653] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5799.920495] Lustre: Mounted lustre-client [ 5800.353856] LustreError: 253798:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3cbb99000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5800.386141] Lustre: Unmounted lustre-client [ 5817.296637] Key type lgssc unregistered [ 5817.416438] LNet: 254202:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5817.418599] LNetError: 254202:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5817.426443] LNet: Removed LNI 192.168.204.5@tcp [ 5817.650138] Key type .llcrypt unregistered [ 5817.651479] Key type ._llcrypt unregistered [ 5822.490894] Key type ._llcrypt registered [ 5822.491924] Key type .llcrypt registered [ 5822.912420] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 21:36:51 (1777426611) [ 5823.559678] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5823.596414] alg: No test for adler32 (adler32-zlib) [ 5824.451859] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 5824.526770] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 5826.112126] Key type lgssc registered [ 5826.456086] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5885.076018] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5894.137472] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5895.218754] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5900.783693] Lustre: Mounted lustre-client [ 5901.217291] LustreError: 257244:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c7958000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5901.246038] Lustre: Unmounted lustre-client [ 5918.115787] Key type lgssc unregistered [ 5918.224459] LNet: 257646:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5918.226788] LNetError: 257646:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5918.233657] LNet: Removed LNI 192.168.204.5@tcp [ 5918.445746] Key type .llcrypt unregistered [ 5918.447348] Key type ._llcrypt unregistered [ 5923.341506] Key type ._llcrypt registered [ 5923.342707] Key type .llcrypt registered [ 5923.822439] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 21:38:32 (1777426712) [ 5924.711541] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5924.725758] alg: No test for adler32 (adler32-zlib) [ 5925.575271] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 5925.662395] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 5927.248146] Key type lgssc registered [ 5927.586814] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5944.038087] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5945.128074] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5951.067555] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5952.226486] Lustre: Mounted lustre-client [ 5957.602807] Lustre: lustre-MDT0000-mdc-ffff88c3cbb99800: Connection to lustre-MDT0000 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5959.678126] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5959.689461] LustreError: 260708:0:(file.c:6460:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 5959.792236] LustreError: 260727:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3cbb99800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5959.793783] LustreError: MGC192.168.204.105@tcp: Connection to MGS (at 192.168.204.105@tcp) was lost; in progress operations using this service will fail [ 5959.820170] Lustre: Unmounted lustre-client [ 5970.593311] Key type lgssc unregistered [ 5970.701330] LNet: 261120:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5970.704541] LNetError: 261120:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5970.712247] LNet: Removed LNI 192.168.204.5@tcp [ 5970.919601] Key type .llcrypt unregistered [ 5970.920800] Key type ._llcrypt unregistered [ 5975.515122] Key type ._llcrypt registered [ 5975.516045] Key type .llcrypt registered [ 5975.952746] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 21:39:24 (1777426764) [ 5976.766043] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5976.772973] alg: No test for adler32 (adler32-zlib) [ 5977.638740] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 5977.724241] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 5979.304147] Key type lgssc registered [ 5979.644731] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5995.611339] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5996.656477] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6002.446186] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6003.627657] Lustre: Mounted lustre-client [ 6008.803286] Lustre: lustre-MDT0001-mdc-ffff88c3e0411800: Connection to lustre-MDT0001 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6010.983399] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6011.269221] LustreError: 264210:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3e0411800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6011.295147] Lustre: Unmounted lustre-client [ 6021.874532] Key type lgssc unregistered [ 6021.977509] LNet: 264605:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6021.980421] LNetError: 264605:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6021.989598] LNet: Removed LNI 192.168.204.5@tcp [ 6022.202780] Key type .llcrypt unregistered [ 6022.204325] Key type ._llcrypt unregistered [ 6026.767030] Key type ._llcrypt registered [ 6026.768037] Key type .llcrypt registered [ 6027.176480] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 21:40:15 (1777426815) [ 6032.635503] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6032.661053] alg: No test for adler32 (adler32-zlib) [ 6033.517513] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 6033.595625] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 6035.176233] Key type lgssc registered [ 6035.584767] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6070.050178] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6071.191794] Lustre: Mounted lustre-client [ 6084.068664] Lustre: lustre-MDT0001-mdc-ffff88c3c4663000: Connection to lustre-MDT0001 (at 192.168.204.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6086.030423] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6096.318179] Lustre: Unmounted lustre-client [ 6122.008719] Key type lgssc unregistered [ 6122.144587] LNet: 270343:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6122.147699] LNetError: 270343:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6122.158206] LNet: Removed LNI 192.168.204.5@tcp [ 6122.423038] Key type .llcrypt unregistered [ 6122.425949] Key type ._llcrypt unregistered [ 6127.973211] Key type ._llcrypt registered [ 6127.974399] Key type .llcrypt registered [ 6128.482088] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 21:41:57 (1777426917) [ 6129.078511] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 6129.675273] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 21:41:58 (1777426918) [ 6130.280849] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 6130.830221] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 21:41:59 (1777426919) [ 6131.346406] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 6131.943778] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 21:42:00 (1777426920) [ 6132.486745] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 6133.090207] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 21:42:01 (1777426921) [ 6133.642248] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 6134.241730] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 21:42:02 (1777426922) [ 6137.389234] Key type .llcrypt unregistered [ 6137.390751] Key type ._llcrypt unregistered [ 6139.899880] Key type ._llcrypt registered [ 6139.904154] Key type .llcrypt registered [ 6140.080676] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6140.093418] alg: No test for adler32 (adler32-zlib) [ 6140.960357] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 6141.068859] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 6142.656200] Key type lgssc registered [ 6143.106664] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6169.726131] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6170.911060] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6178.592123] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6184.923597] Lustre: Mounted lustre-client [ 6185.391842] LustreError: 275929:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d155e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6185.430199] Lustre: Unmounted lustre-client [ 6208.815944] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 21:43:17 (1777426997) [ 6219.087965] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6220.248118] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6236.764387] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6236.916988] Lustre: Mounted lustre-client [ 6237.233683] LustreError: 278039:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d07ba800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6237.258916] Lustre: Unmounted lustre-client [ 6266.308248] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 21:44:15 (1777427055) [ 6290.592359] LNet: 1 local NIs in recovery (showing 1): 192.168.204.5@tcp [ 6853.334431] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6854.586103] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6871.654283] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6913.101523] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 21:55:01 (1777427701) [ 6916.925181] Key type lgssc unregistered [ 6917.042588] LNet: 283571:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6917.045083] LNetError: 283571:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6917.052587] LNet: Removed LNI 192.168.204.5@tcp [ 6917.289617] Key type .llcrypt unregistered [ 6917.291267] Key type ._llcrypt unregistered [ 6999.790991] Key type ._llcrypt registered [ 6999.792261] Key type .llcrypt registered [ 7000.086608] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7000.091619] alg: No test for adler32 (adler32-zlib) [ 7000.957625] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 7001.053932] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 7002.648125] Key type lgssc registered [ 7003.062206] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7034.655523] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7035.923161] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7043.458691] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7056.245798] Key type lgssc unregistered [ 7056.373454] LNet: 287158:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7056.375844] LNetError: 287158:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7056.383454] LNet: Removed LNI 192.168.204.5@tcp [ 7056.648383] Key type .llcrypt unregistered [ 7056.649489] Key type ._llcrypt unregistered [ 7070.580601] Key type ._llcrypt registered [ 7070.581844] Key type .llcrypt registered [ 7071.049751] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 21:57:39 (1777427859) [ 7078.123110] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7078.166541] alg: No test for adler32 (adler32-zlib) [ 7079.046193] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 7079.145471] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 7080.728127] Key type lgssc registered [ 7081.197919] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7098.673751] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 21:58:07 (1777427887) [ 7102.640141] Key type lgssc unregistered [ 7102.753481] LNet: 290704:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7102.755989] LNetError: 290704:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7102.762485] LNet: Removed LNI 192.168.204.5@tcp [ 7103.007401] Key type .llcrypt unregistered [ 7103.009108] Key type ._llcrypt unregistered [ 7106.952406] Key type ._llcrypt registered [ 7106.953592] Key type .llcrypt registered [ 7107.169795] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7107.183141] alg: No test for adler32 (adler32-zlib) [ 7108.048488] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 7108.141752] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 7109.736179] Key type lgssc registered [ 7110.167127] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7130.271693] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7131.633770] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7139.135607] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7221.878252] LNet: Added LNI 192.168.204.5@tcp50 [8/256/0/180] [ 7222.707525] LNet: Removed LNI 192.168.204.5@tcp [ 7224.175265] Lustre: 294976:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff88c3c4665000: config has no valid NIDs, force dynamic NIDs [ 7225.226248] Lustre: Mounted lustre-client [ 7225.250381] LustreError: 294991:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c4665000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7225.278165] Lustre: Unmounted lustre-client [ 7226.323852] Key type lgssc unregistered [ 7226.483565] LNet: 295241:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7226.486619] LNetError: 295241:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7226.493497] LNet: Removed LNI 192.168.204.5@tcp50 [ 7226.713128] Key type .llcrypt unregistered [ 7226.714674] Key type ._llcrypt unregistered [ 7236.546098] Key type ._llcrypt registered [ 7236.547405] Key type .llcrypt registered [ 7236.704413] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7236.709507] alg: No test for adler32 (adler32-zlib) [ 7237.569351] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 7237.647780] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 7239.224225] Key type lgssc registered [ 7239.825216] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7269.484505] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7270.998434] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7273.731161] LNet: Added LNI 192.168.204.5@tcp50 [8/256/0/180] [ 7274.002254] LNet: Removed LNI 192.168.204.5@tcp [ 7275.052536] Lustre: 297879:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff88c3c50a7800: config has no valid NIDs, force dynamic NIDs [ 7276.107392] Lustre: Mounted lustre-client [ 7276.289869] LustreError: 297914:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3c50a7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7276.338758] Lustre: Unmounted lustre-client [ 7297.813405] Key type lgssc unregistered [ 7297.949404] LNet: 298754:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7297.951712] LNetError: 298754:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7297.959574] LNet: Removed LNI 192.168.204.5@tcp50 [ 7298.129356] Key type .llcrypt unregistered [ 7298.131318] Key type ._llcrypt unregistered [ 7301.625987] Key type ._llcrypt registered [ 7301.627863] Key type .llcrypt registered [ 7302.253606] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 22:01:30 (1777428090) [ 7303.127636] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7303.152925] alg: No test for adler32 (adler32-zlib) [ 7304.030844] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 7304.120356] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 7305.704186] Key type lgssc registered [ 7306.225573] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7323.457948] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7324.556996] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7330.261554] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7331.429053] Lustre: Mounted lustre-client [ 7351.273882] Lustre: Mounted fs15246-client [ 7355.936752] LustreError: 302880:0:(lov_obd.c:783:lov_cleanup()) fs15246-clilov-ffff88c3d858b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7355.955558] Lustre: Unmounted fs15246-client [ 7368.447156] LustreError: 303098:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff88c3d155a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7368.469885] Lustre: Unmounted lustre-client [ 7393.710446] Key type lgssc unregistered [ 7393.822646] LNet: 303501:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7393.826264] LNetError: 303501:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7393.839502] LNet: Removed LNI 192.168.204.5@tcp [ 7394.043227] Key type .llcrypt unregistered [ 7394.044465] Key type ._llcrypt unregistered [ 7397.607662] Key type ._llcrypt registered [ 7397.608770] Key type .llcrypt registered [ 7398.091338] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 22:03:06 (1777428186) [ 7398.857455] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7398.871729] alg: No test for adler32 (adler32-zlib) [ 7399.738543] Lustre: Lustre: Build Version: 2.17.50_193_g6a09ae0 [ 7399.831699] LNet: Added LNI 192.168.204.5@tcp [8/256/0/180] [ 7401.424163] Key type lgssc registered [ 7401.817210] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7445.416702] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7446.670642] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7454.029482] Lustre: DEBUG MARKER: oleg405-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7504.674413] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 7373 sec ========== 22:04:53 (1777428293) [ 7505.261453] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 22:04:53 (1777428293) === [ 7506.463836] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 22:04:55 (1777428295) === [ 7517.615934] Key type lgssc unregistered [ 7517.734511] LNet: 312645:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7517.737541] LNetError: 312645:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7517.745564] LNet: Removed LNI 192.168.204.5@tcp [ 7518.003346] Key type .llcrypt unregistered [ 7518.004672] Key type ._llcrypt unregistered