[ 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.16.2-1.fc38 04/01/2014 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 412469425 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 0x000f5b50-0x000f5b5f] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F5970 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE1BB7 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE1A53 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 001A13 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE1AC7 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE1B57 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE1B8F 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe1a53-0xbffe1ac6] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1a52] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe1ac7-0xbffe1b56] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe1b57-0xbffe1b8e] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe1b8f-0xbffe1bb6] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524588K 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.001010] APIC: Switch to symmetric I/O mode setup [ 0.002318] x2apic enabled [ 0.003005] Switched APIC routing to physical x2apic. [ 0.004008] kvm-guest: setup PV IPIs [ 0.007000] ..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.007016] Calibrating delay loop (skipped) preset value.. 4800.00 BogoMIPS (lpj=2400000) [ 0.008005] pid_max: default: 32768 minimum: 301 [ 0.009165] LSM: Security Framework initializing [ 0.011012] Yama: becoming mindful. [ 0.012023] SELinux: Initializing. [ 0.013045] *** VALIDATE selinux *** [ 0.020669] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024251] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025229] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026137] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027112] *** VALIDATE tmpfs *** [ 0.029122] *** VALIDATE proc *** [ 0.029954] *** VALIDATE cgroup *** [ 0.030005] *** VALIDATE cgroup2 *** [ 0.031107] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.032103] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.033003] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.034020] Spectre V2 : User space: Vulnerable [ 0.035003] Speculative Store Bypass: Vulnerable [ 0.037820] debug: unmapping init [mem 0xffffffffb9a59000-0xffffffffb9a60fff] [ 0.039886] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.040612] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.041018] ... version: 2 [ 0.042008] ... bit width: 48 [ 0.043007] ... generic registers: 4 [ 0.044009] ... value mask: 0000ffffffffffff [ 0.045013] ... max period: 00007fffffffffff [ 0.046032] ... fixed-purpose events: 3 [ 0.047010] ... event mask: 000000070000000f [ 0.048239] rcu: Hierarchical SRCU implementation. [ 0.050428] smp: Bringing up secondary CPUs ... [ 0.051422] x86: Booting SMP configuration: [ 0.052014] .... node #0, CPUs: #1 #2 #3 [ 0.056098] smp: Brought up 1 node, 4 CPUs [ 0.058010] smpboot: Max logical packages: 1 [ 0.059012] smpboot: Total of 4 processors activated (19200.00 BogoMIPS) [ 0.263119] node 0 deferred pages initialised in 203ms [ 0.267010] devtmpfs: initialized [ 0.268142] x86/mm: Memory block size: 128MB [ 0.271011] gcov: version magic: 0x41383552 [ 0.273449] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.276101] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.278343] pinctrl core: initialized pinctrl subsystem [ 0.280120] [ 0.280521] ************************************************************* [ 0.282010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.283006] ** ** [ 0.285008] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.287007] ** ** [ 0.288006] ** This means that this kernel is built to expose internal ** [ 0.290008] ** IOMMU data structures, which may compromise security on ** [ 0.291006] ** your system. ** [ 0.293007] ** ** [ 0.295007] ** If you see this message and you are not debugging the ** [ 0.296006] ** kernel, report this immediately to your vendor! ** [ 0.298007] ** ** [ 0.300007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.301005] ************************************************************* [ 0.303766] NET: Registered protocol family 16 [ 0.305419] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.307049] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.309045] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.312039] cpuidle: using governor menu [ 0.313638] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.316499] PCI: Using configuration type 1 for base access [ 0.319188] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.328116] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.330031] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.333167] cryptd: max_cpu_qlen set to 1000 [ 0.336306] ACPI: Added _OSI(Module Device) [ 0.338017] ACPI: Added _OSI(Processor Device) [ 0.340011] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.341008] ACPI: Added _OSI(Processor Aggregator Device) [ 0.345605] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.350365] ACPI: Interpreter enabled [ 0.351033] ACPI: PM: (supports S0 S3 S4 S5) [ 0.351825] ACPI: Using IOAPIC for interrupt routing [ 0.353067] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.356222] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.363710] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.365023] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.367010] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.369061] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.373020] acpiphp: Slot [2] registered [ 0.374035] acpiphp: Slot [3] registered [ 0.375088] acpiphp: Slot [4] registered [ 0.376078] acpiphp: Slot [5] registered [ 0.377090] acpiphp: Slot [6] registered [ 0.379065] acpiphp: Slot [7] registered [ 0.380057] acpiphp: Slot [8] registered [ 0.381061] acpiphp: Slot [9] registered [ 0.382058] acpiphp: Slot [10] registered [ 0.383101] acpiphp: Slot [11] registered [ 0.385055] acpiphp: Slot [12] registered [ 0.386057] acpiphp: Slot [13] registered [ 0.387056] acpiphp: Slot [14] registered [ 0.388059] acpiphp: Slot [15] registered [ 0.389059] acpiphp: Slot [16] registered [ 0.390077] acpiphp: Slot [17] registered [ 0.391073] acpiphp: Slot [18] registered [ 0.393068] acpiphp: Slot [19] registered [ 0.394159] acpiphp: Slot [20] registered [ 0.396080] acpiphp: Slot [21] registered [ 0.398145] acpiphp: Slot [22] registered [ 0.399070] acpiphp: Slot [23] registered [ 0.400089] acpiphp: Slot [24] registered [ 0.401065] acpiphp: Slot [25] registered [ 0.403075] acpiphp: Slot [26] registered [ 0.404056] acpiphp: Slot [27] registered [ 0.405000] acpiphp: Slot [28] registered [ 0.405000] acpiphp: Slot [29] registered [ 0.407088] acpiphp: Slot [30] registered [ 0.408061] acpiphp: Slot [31] registered [ 0.409057] PCI host bridge to bus 0000:00 [ 0.410018] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.412011] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.413012] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.415013] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.417010] pci_bus 0000:00: root bus resource [mem 0x180000000-0x1ffffffff window] [ 0.419015] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.420164] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.424325] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.428460] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.433918] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.438051] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.439013] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.441012] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.443011] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.445462] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.447621] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.449024] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.451605] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.455021] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.469014] pci 0000:00:02.0: reg 0x20: [mem 0xfebf4000-0xfebf7fff 64bit pref] [ 0.473035] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.477000] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.490019] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.500071] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.519020] pci 0000:00:05.0: reg 0x20: [mem 0xfebf8000-0xfebfbfff 64bit pref] [ 0.531832] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.536010] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.540027] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.552015] pci 0000:00:06.0: reg 0x20: [mem 0xfebfc000-0xfebfffff 64bit pref] [ 0.559333] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.563436] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.565416] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.567368] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.569252] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.573178] iommu: Default domain type: Passthrough [ 0.574435] SCSI subsystem initialized [ 0.576157] ACPI: bus type USB registered [ 0.577138] usbcore: registered new interface driver usbfs [ 0.579095] usbcore: registered new interface driver hub [ 0.581100] usbcore: registered new device driver usb [ 0.583198] pps_core: LinuxPPS API ver. 1 registered [ 0.584013] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.587083] PTP clock support registered [ 0.590047] EDAC MC: Ver: 3.0.0 [ 0.591360] PCI: Using ACPI for IRQ routing [ 0.593740] NetLabel: Initializing [ 0.595008] NetLabel: domain hash size = 128 [ 0.596009] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.598112] NetLabel: unlabeled traffic allowed by default [ 0.601200] vgaarb: loaded [ 0.603305] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.604016] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.609237] clocksource: Switched to clocksource kvm-clock [ 0.717408] VFS: Disk quotas dquot_6.6.0 [ 0.718591] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.720618] *** VALIDATE ramfs *** [ 0.721584] *** VALIDATE hugetlbfs *** [ 0.722873] pnp: PnP ACPI init [ 0.724854] pnp: PnP ACPI: found 6 devices [ 0.741027] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.744110] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.746210] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.748327] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.750848] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.753178] pci_bus 0000:00: resource 8 [mem 0x180000000-0x1ffffffff window] [ 0.755312] NET: Registered protocol family 2 [ 0.757318] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.761545] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.764553] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.768728] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.770842] TCP: Hash tables configured (established 65536 bind 65536) [ 0.772695] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.774948] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.777532] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.779537] NET: Registered protocol family 1 [ 0.781669] RPC: Registered named UNIX socket transport module. [ 0.783796] RPC: Registered udp transport module. [ 0.785527] RPC: Registered tcp transport module. [ 0.786865] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.789201] NET: Registered protocol family 44 [ 0.790294] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.792143] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.793705] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.795435] PCI: CLS 0 bytes, default 64 [ 0.796298] Unpacking initramfs... [ 2.350399] debug: unmapping init [mem 0xffff99023cc64000-0xffff99023ffcffff] [ 2.355844] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.357789] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.360505] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 3.097552] Initialise system trusted keyrings [ 3.099127] Key type blacklist registered [ 3.100957] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.109270] zbud: loaded [ 3.113608] *** VALIDATE nfs *** [ 3.114844] *** VALIDATE nfs4 *** [ 3.116350] pstore: using deflate compression [ 3.119758] Platform Keyring initialized [ 3.343723] NET: Registered protocol family 38 [ 3.344971] Key type asymmetric registered [ 3.346156] Asymmetric key parser 'x509' registered [ 3.347481] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.349761] io scheduler mq-deadline registered [ 3.350932] io scheduler kyber registered [ 3.352124] io scheduler bfq registered [ 3.359589] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.364450] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.371870] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.374123] ACPI: Power Button [PWRF] [ 3.478362] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.575168] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.723162] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.772672] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.820567] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.825411] Non-volatile memory driver v1.3 [ 3.827270] Linux agpgart interface v0.103 [ 3.857245] virtio_blk virtio1: [vda] 133248 512-byte logical blocks (68.2 MB/65.1 MiB) [ 3.860582] vda: detected capacity change from 0 to 68222976 [ 3.904469] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.917824] vdb: detected capacity change from 0 to 1073741824 [ 3.928543] libphy: Fixed MDIO Bus: probed [ 3.938981] usbcore: registered new interface driver usbserial_generic [ 3.941341] usbserial: USB Serial support registered for generic [ 3.943665] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.948717] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.950675] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.953169] mousedev: PS/2 mouse device common for all mice [ 3.957363] rtc_cmos 00:05: RTC can wake from S4 [ 3.960962] rtc_cmos 00:05: registered as rtc0 [ 3.963245] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.964315] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.964351] intel_pstate: CPU model not supported [ 3.974213] hid: raw HID events driver (C) Jiri Kosina [ 3.982136] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.983380] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 4.014265] usbcore: registered new interface driver usbhid [ 4.019060] usbhid: USB HID core driver [ 4.020714] drop_monitor: Initializing network drop monitor service [ 4.024306] Initializing XFRM netlink socket [ 4.026506] NET: Registered protocol family 10 [ 4.030739] Segment Routing with IPv6 [ 4.032308] NET: Registered protocol family 17 [ 4.034375] mpls_gso: MPLS GSO support [ 4.040163] RAS: Correctable Errors collector initialized. [ 4.043318] AVX version of gcm_enc/dec engaged. [ 4.044792] AES CTR mode by8 optimization enabled [ 4.165730] sched_clock: Marking stable (4165714465, 0)->(4992730727, -827016262) [ 4.169681] registered taskstats version 1 [ 4.174137] Loading compiled-in X.509 certificates [ 4.175777] zswap: loaded using pool lzo/zbud [ 4.212540] Key type big_key registered [ 4.230824] Key type encrypted registered [ 4.232175] ima: No TPM chip found, activating TPM-bypass! [ 4.233752] ima: Allocated hash algorithm: sha1 [ 4.243529] ima: No architecture policies found [ 4.244730] evm: Initialising EVM extended attributes: [ 4.246708] evm: security.selinux [ 4.248176] evm: security.ima [ 4.249460] evm: security.capability [ 4.250952] evm: HMAC attrs: 0x1 [ 4.254371] rtc_cmos 00:05: setting system clock to 2025-10-10 23:06:07 UTC (1760137567) [ 4.261308] debug: unmapping init [mem 0xffffffffbaa03000-0xffffffffbabfffff] [ 4.264776] debug: unmapping init [mem 0xffffffffb9782000-0xffffffffb9a58fff] [ 4.276769] Write protecting the kernel read-only data: 28672k [ 4.285298] debug: unmapping init [mem 0xffffffffb7e03000-0xffffffffb7ffffff] [ 4.287926] debug: unmapping init [mem 0xffffffffb8714000-0xffffffffb87fffff] [ 4.327328] 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) [ 4.333947] systemd[1]: Detected virtualization kvm. [ 4.336480] systemd[1]: Detected architecture x86-64. [ 4.338235] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 4.375319] systemd[1]: No hostname configured. [ 4.379394] systemd[1]: Set hostname to . [ 4.381037] random: systemd: uninitialized urandom read (16 bytes read) [ 4.383559] systemd[1]: Initializing machine ID from random generator. [ 4.454594] random: ln: uninitialized urandom read (6 bytes read) [ 4.571900] random: systemd: uninitialized urandom read (16 bytes read) [ 4.574450] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 4.581205] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 4.587288] systemd[1]: Reached target Local Encrypted Volumes. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Initrd Root Device. Starting Setup Virtual Console... [ OK ] Reached target Slices. [ OK ] Reached target Paths. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Timers. Starting Create Volatile Files and Directories... [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Swap. Starting Apply Kernel Variables... Starting Journal Service... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 5.441167] device-mapper: uevent: version 1.0.3 [ 5.442989] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization.[ 6.485067] virtio_net virtio0 ens2: renamed from eth0 [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 6.568245] random: fast init done [ 6.669459] scsi host0: ata_piix [ 6.679285] scsi host1: ata_piix [ 6.680475] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 6.686711] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 11.781271] random: crng init done [ 11.782486] random: 7 urandom warning(s) missed due to ratelimiting [ 11.920544] dracut-initqueue[586]: 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.618803] 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 dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Timers. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. Stopping Hardware RNG Entropy Gatherer Daemon... [ 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 target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 15.406515] printk: systemd: 26 output lines suppressed due to ratelimiting [ 16.259344] SELinux: Disabled at runtime. [ 16.359602] 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) [ 16.381681] systemd[1]: Detected virtualization kvm. [ 16.383638] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 17.435838] systemd[1]: initrd-switch-root.service: Succeeded. [ 17.440203] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 17.448810] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 17.456897] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 17.459623] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 17.475430] systemd[1]: Starting Journal Service... Starting Journal Service... [ 17.481988] systemd[1]: Created slice User and Session Slice. [ OK ] Created slice User and Session Slice. [ OK ] Listening on Process Core Dump Socket. [ OK ] Reached target Slices. Starting Remount Root and Kernel File Systems... Starting Create list of required st…ce nodes for the current kernel... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Mounting Kernel Debug File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on udev Control Socket. Mounting POSIX Message Queue File System... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Created slice system-getty.slice. [ OK ] Reached target RPC Port Mapper. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. Mounting Huge Pages File System... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Reached target Local Encrypted Volumes. Activating swap /dev/disk/by-label/SWAP... Starting Apply Kernel Variables... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Reached target rpc_pipefs.target. [ OK ] Reached target Paths. [ OK ] Started Journ[ 17.784084] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS al Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 18.203320] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 18.772451] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 18.834384] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 19.091308] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 19.119303] EDAC sbridge: Ver: 1.1.2 [ 21.429194] Key type dns_resolver registered [ 22.208787] NFS: Registering the id_resolver key type [ 22.210683] Key type id_resolver registered [ 22.221344] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting 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 daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Login Service... Starting Restore /run/initramfs on shutdown... [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Started Login Service. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... Starting System Logging Service... [ 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 oleg345-client login: [ 56.211223] libcfs: loading out-of-tree module taints kernel. [ 56.233685] Key type ._llcrypt registered [ 56.234725] Key type .llcrypt registered [ 56.547131] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 56.552229] alg: No test for adler32 (adler32-zlib) [ 57.565654] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 57.910468] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 59.519160] Key type lgssc registered [ 60.041349] Lustre: Echo OBD driver; http://www.lustre.org/ [ 117.563434] Lustre: Mounted lustre-client [ 119.840448] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 132.255449] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing check_logdir /tmp/testlogs/ [ 133.655755] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing yml_node [ 135.296375] Lustre: DEBUG MARKER: Client: 2.16.58.105 [ 136.334231] Lustre: DEBUG MARKER: MDS: 2.16.58.105 [ 137.287451] Lustre: DEBUG MARKER: OSS: 2.16.58.105 [ 137.926473] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Oct 10 19:08:20 EDT 2025 [ 143.328191] Lustre: lustre-OST0000-osc-ffff9902914c1800: disconnect after 24s idle [ 144.673627] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 145.218560] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 145.743662] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 156.005348] LustreError: 8990:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 156.021133] Lustre: Unmounted lustre-client [ 219.093546] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 220.283240] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 227.653674] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 255.904965] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 19:10:18 (1760137818) [ 256.802890] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 257.463627] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 19:10:20 (1760137820) [ 267.526932] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 268.895471] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 275.346885] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 290.802818] Lustre: Mounted lustre-client [ 292.617494] LustreError: 14414:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902904a4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 292.627690] LustreError: 14414:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 292.630611] LustreError: 14414:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 292.654151] Lustre: Unmounted lustre-client [ 318.766527] Key type lgssc unregistered [ 318.896589] LNet: 14822:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 318.898796] LNetError: 14822:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 318.906655] LNet: Removed LNI 192.168.203.45@tcp [ 319.200103] Key type .llcrypt unregistered [ 319.201617] Key type ._llcrypt unregistered [ 324.754602] Key type ._llcrypt registered [ 324.756482] Key type .llcrypt registered [ 325.183651] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 19:11:27 (1760137887) [ 325.689820] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 325.715726] alg: No test for adler32 (adler32-zlib) [ 326.580619] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 326.668902] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 328.247126] Key type lgssc registered [ 328.651419] Lustre: Echo OBD driver; http://www.lustre.org/ [ 361.433060] Lustre: Mounted lustre-client [ 441.505118] LustreError: 18137:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902980ac800: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 441.509832] LustreError: 18137:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 441.520135] Lustre: Unmounted lustre-client [ 460.205100] Key type lgssc unregistered [ 460.317553] LNet: 18601:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 460.321336] LNetError: 18601:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 460.329721] LNet: Removed LNI 192.168.203.45@tcp [ 460.601946] Key type .llcrypt unregistered [ 460.603453] Key type ._llcrypt unregistered [ 463.725718] Key type ._llcrypt registered [ 463.726757] Key type .llcrypt registered [ 464.178238] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 19:13:46 (1760138026) [ 464.855326] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 464.881274] alg: No test for adler32 (adler32-zlib) [ 465.729051] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 465.811300] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 467.399104] Key type lgssc registered [ 467.759439] Lustre: Echo OBD driver; http://www.lustre.org/ [ 484.277777] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 485.361066] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 491.377322] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 506.863388] Lustre: Mounted lustre-client [ 510.774060] LustreError: 21700:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028665f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 510.782323] LustreError: 21700:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 510.806851] Lustre: Unmounted lustre-client [ 528.205966] Key type lgssc unregistered [ 528.327550] LNet: 22102:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 528.329666] LNetError: 22102:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 528.339537] LNet: Removed LNI 192.168.203.45@tcp [ 528.591182] Key type .llcrypt unregistered [ 528.593164] Key type ._llcrypt unregistered [ 532.451996] Key type ._llcrypt registered [ 532.453635] Key type .llcrypt registered [ 532.976147] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 19:14:55 (1760138095) [ 533.786650] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 533.796869] alg: No test for adler32 (adler32-zlib) [ 534.629193] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 534.697819] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 536.271181] Key type lgssc registered [ 536.665326] Lustre: Echo OBD driver; http://www.lustre.org/ [ 554.147787] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 555.373717] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 561.677816] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 572.398561] Lustre: Mounted lustre-client [ 575.270114] LustreError: 24790:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902904a4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 575.277972] LustreError: 24790:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 575.300105] Lustre: Unmounted lustre-client [ 584.860333] Key type lgssc unregistered [ 584.978672] LNet: 25192:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 584.981246] LNetError: 25192:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 584.991804] LNet: Removed LNI 192.168.203.45@tcp [ 585.249325] Key type .llcrypt unregistered [ 585.250386] Key type ._llcrypt unregistered [ 590.399934] Key type ._llcrypt registered [ 590.401169] Key type .llcrypt registered [ 590.847484] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 19:15:53 (1760138153) [ 591.793306] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 591.814464] alg: No test for adler32 (adler32-zlib) [ 592.693137] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 592.783167] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 594.367168] Key type lgssc registered [ 594.789976] Lustre: Echo OBD driver; http://www.lustre.org/ [ 612.260786] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 613.562366] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 619.763161] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 635.376825] Lustre: Mounted lustre-client [ 640.483338] Lustre: lustre-MDT0000-mdc-ffff9902914c7800: Connection to lustre-MDT0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 645.602175] Lustre: lustre-MDT0001-mdc-ffff9902914c7800: Connection to lustre-MDT0001 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 660.264725] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 660.831164] Lustre: 26146:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760138208/real 1760138208] req@000000000658eabe x1845638627072384/t0(0) o400->MGC192.168.203.145@tcp@192.168.203.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1760138224 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 660.844428] LustreError: MGC192.168.203.145@tcp: Connection to MGS (at 192.168.203.145@tcp) was lost; in progress operations using this service will fail [ 670.503228] LustreError: 28358:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 670.519170] Lustre: Unmounted lustre-client [ 675.036371] Key type lgssc unregistered [ 675.166435] LNet: 28748:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 675.169155] LNetError: 28748:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 675.179374] LNet: Removed LNI 192.168.203.45@tcp [ 675.414569] Key type .llcrypt unregistered [ 675.415783] Key type ._llcrypt unregistered [ 680.502315] Key type ._llcrypt registered [ 680.503291] Key type .llcrypt registered [ 680.929761] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 19:17:23 (1760138243) [ 681.622700] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 681.650496] alg: No test for adler32 (adler32-zlib) [ 682.518733] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 682.597214] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 684.175140] Key type lgssc registered [ 684.549163] Lustre: Echo OBD driver; http://www.lustre.org/ [ 702.073678] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 703.291890] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 709.560513] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 724.977079] Lustre: Mounted lustre-client [ 730.083631] Lustre: lustre-OST0000-osc-ffff990285f7a000: Connection to lustre-OST0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 734.009802] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 744.296875] LustreError: 31859:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 744.312675] Lustre: Unmounted lustre-client [ 761.757217] Key type lgssc unregistered [ 761.885467] LNet: 32261:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 761.887408] LNetError: 32261:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 761.894396] LNet: Removed LNI 192.168.203.45@tcp [ 762.168213] Key type .llcrypt unregistered [ 762.169350] Key type ._llcrypt unregistered [ 767.501492] Key type ._llcrypt registered [ 767.502422] Key type .llcrypt registered [ 767.996928] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 19:18:50 (1760138330) [ 768.757434] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 768.764703] alg: No test for adler32 (adler32-zlib) [ 769.616227] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 769.702702] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 771.287096] Key type lgssc registered [ 771.673550] Lustre: Echo OBD driver; http://www.lustre.org/ [ 788.923334] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 790.151133] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 796.180678] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 806.897726] Lustre: Mounted lustre-client [ 808.736128] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 810.105752] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 820.690844] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2025-10-1019h19m43s [ 821.404678] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 822.241703] Lustre: lustre-MDT0000-mdc-ffff99028927a800: Connection to lustre-MDT0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 828.984187] LustreError: 35955:0:(lmv_obd.c:1434:lmv_statfs()) lustre-MDT0000-mdc-ffff99028927a800: can't stat MDS #0: rc = -19 [ 829.481388] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 833.440724] LustreError: MGC192.168.203.145@tcp: Connection to MGS (at 192.168.203.145@tcp) was lost; in progress operations using this service will fail [ 833.445462] Lustre: Evicted from MGS (at 192.168.203.145@tcp) after server handle changed from 0xfd023e4cc4446318 to 0xfd023e4cc44466c9 [ 833.448451] Lustre: MGC192.168.203.145@tcp: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 834.347927] Lustre: DEBUG MARKER: Wait for df (35955) ... [ 834.466674] LustreError: lustre-MDT0000-mdc-ffff99028927a800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 834.471816] Lustre: lustre-MDT0000-mdc-ffff99028927a800: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 834.835469] Lustre: DEBUG MARKER: done [ 835.140074] LustreError: 36563:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028927a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 835.143313] LustreError: 36563:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 835.163106] Lustre: Unmounted lustre-client [ 852.340913] Key type lgssc unregistered [ 852.463447] LNet: 36964:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 852.465895] LNetError: 36964:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 852.474852] LNet: Removed LNI 192.168.203.45@tcp [ 852.749851] Key type .llcrypt unregistered [ 852.751111] Key type ._llcrypt unregistered [ 867.286481] Key type ._llcrypt registered [ 867.287789] Key type .llcrypt registered [ 867.488809] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 867.494868] alg: No test for adler32 (adler32-zlib) [ 868.372747] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 868.459683] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 870.047240] Key type lgssc registered [ 870.447660] Lustre: Echo OBD driver; http://www.lustre.org/ [ 899.111672] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 900.253140] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 907.264539] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 936.772173] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 19:21:39 (1760138499) [ 947.086237] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 948.289650] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 954.440306] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 965.104127] Lustre: Mounted lustre-client [ 967.471113] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2025-10-1019h22m10s [ 967.950133] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 970.272732] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 971.121531] Lustre: DEBUG MARKER: Creating a test file and stat it [ 991.199148] Lustre: 43811:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760138534/real 1760138534] req@000000006c5c7a56 x1845638915429760/t0(0) o101->lustre-MDT0000-mdc-ffff9902886c8000@192.168.203.145@tcp:12/10 lens 576/1152 e 0 to 1 dl 1760138554 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:0 [ 991.205878] Lustre: lustre-MDT0000-mdc-ffff9902886c8000: Connection to lustre-MDT0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 991.215074] Lustre: lustre-MDT0000-mdc-ffff9902886c8000: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 1011.706043] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1012.759921] Lustre: DEBUG MARKER: done [ 1013.574998] LustreError: 44292:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902886c8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1013.580914] LustreError: 44292:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1013.601076] Lustre: Unmounted lustre-client [ 1035.387395] Key type lgssc unregistered [ 1035.621050] LNet: 44695:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1035.629106] LNetError: 44695:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1035.644670] LNet: Removed LNI 192.168.203.45@tcp [ 1036.261269] Key type .llcrypt unregistered [ 1036.264535] Key type ._llcrypt unregistered [ 1065.349960] Key type ._llcrypt registered [ 1065.351802] Key type .llcrypt registered [ 1065.503812] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1065.562802] alg: No test for adler32 (adler32-zlib) [ 1066.469273] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1066.581242] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 1068.199408] Key type lgssc registered [ 1068.714339] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1100.119133] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1101.471347] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1110.178287] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1132.153846] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 19:24:54 (1760138694) [ 1132.706157] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1133.303695] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 19:24:56 (1760138696) [ 1141.073360] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 19:25:03 (1760138703) [ 1150.634084] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1151.800884] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1157.932529] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1173.491480] Lustre: Mounted lustre-client [ 1175.376190] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1176.255885] LustreError: 52525:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902980aa800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1176.268711] LustreError: 52525:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1176.294223] Lustre: Unmounted lustre-client [ 1185.908735] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1202.204552] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1203.381582] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1208.816500] Lustre: Mounted lustre-client [ 1209.700631] LustreError: 53781:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990285f7d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1209.709965] LustreError: 53781:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1209.713664] LustreError: 53781:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1209.736163] Lustre: Unmounted lustre-client [ 1235.343342] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1236.623328] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1236.794915] Lustre: Mounted lustre-client [ 1237.703459] LustreError: 54898:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902912bd800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1237.713416] LustreError: 54898:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1237.715392] LustreError: 54898:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1237.741020] Lustre: Unmounted lustre-client [ 1249.167835] Lustre: DEBUG MARKER: files compared the same [ 1263.846265] Key type lgssc unregistered [ 1263.959529] LNet: 55602:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1263.963074] LNetError: 55602:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1263.971905] LNet: Removed LNI 192.168.203.45@tcp [ 1264.235087] Key type .llcrypt unregistered [ 1264.236243] Key type ._llcrypt unregistered [ 1269.062159] Key type ._llcrypt registered [ 1269.063665] Key type .llcrypt registered [ 1269.490575] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 19:27:12 (1760138832) [ 1270.158119] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1270.178165] alg: No test for adler32 (adler32-zlib) [ 1271.033091] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1271.115368] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 1272.695151] Key type lgssc registered [ 1273.060767] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1290.172101] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1291.482531] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1297.497884] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1313.261828] Lustre: Mounted lustre-client [ 1314.897114] LustreError: 58684:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902980aa000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1314.902562] LustreError: 58684:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1314.920176] Lustre: Unmounted lustre-client [ 1340.620714] Key type lgssc unregistered [ 1340.748567] LNet: 59087:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1340.750894] LNetError: 59087:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1340.759838] LNet: Removed LNI 192.168.203.45@tcp [ 1341.033918] Key type .llcrypt unregistered [ 1341.035690] Key type ._llcrypt unregistered [ 1346.340588] Key type ._llcrypt registered [ 1346.341789] Key type .llcrypt registered [ 1346.819292] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 19:28:29 (1760138909) [ 1347.555933] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1347.593435] alg: No test for adler32 (adler32-zlib) [ 1348.463671] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1348.568760] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 1350.159153] Key type lgssc registered [ 1350.535174] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1410.426362] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1420.580453] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1421.773310] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1443.510085] Key type lgssc unregistered [ 1443.633398] LNet: 62471:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1443.635805] LNetError: 62471:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1443.642306] LNet: Removed LNI 192.168.203.45@tcp [ 1443.903335] Key type .llcrypt unregistered [ 1443.905131] Key type ._llcrypt unregistered [ 1448.859745] Key type ._llcrypt registered [ 1448.860914] Key type .llcrypt registered [ 1449.308539] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 19:30:12 (1760139012) [ 1450.476350] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1450.490967] alg: No test for adler32 (adler32-zlib) [ 1451.346494] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1451.430214] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 1453.007212] Key type lgssc registered [ 1453.373693] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1479.799940] Lustre: Mounted lustre-client [ 1485.133383] LustreError: 64950:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990285f7b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1485.141739] LustreError: 64950:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1485.163077] Lustre: Unmounted lustre-client [ 1506.367472] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 19:31:09 (1760139069) [ 1552.090388] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1563.121638] Lustre: Mounted lustre-client [ 1568.456844] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1568.459790] LustreError: 68900:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff990286d49800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 1568.471118] Lustre: 63452:0:(llite_lib.c:4240:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.145@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 1578.727267] LustreError: 68900:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 1578.729798] LustreError: 68900:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1578.746144] Lustre: Unmounted lustre-client [ 1606.061465] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 19:32:48 (1760139168) [ 1610.408259] Key type lgssc unregistered [ 1610.541710] LNet: 70108:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1610.543848] LNetError: 70108:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1610.551597] LNet: Removed LNI 192.168.203.45@tcp [ 1610.834762] Key type .llcrypt unregistered [ 1610.836222] Key type ._llcrypt unregistered [ 1615.551550] Key type ._llcrypt registered [ 1615.552914] Key type .llcrypt registered [ 1615.758640] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1615.763880] alg: No test for adler32 (adler32-zlib) [ 1616.631300] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1616.727800] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 1618.311240] Key type lgssc registered [ 1618.735734] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1637.489601] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1638.621746] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1645.532944] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1656.306843] Lustre: Mounted lustre-client [ 1657.963165] LustreError: 72622:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902904a0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1657.969114] LustreError: 72622:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 1657.992159] Lustre: Unmounted lustre-client [ 1684.663112] Key type lgssc unregistered [ 1684.830770] LNet: 73026:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1684.833596] LNetError: 73026:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1684.843366] LNet: Removed LNI 192.168.203.45@tcp [ 1685.147346] Key type .llcrypt unregistered [ 1685.148601] Key type ._llcrypt unregistered [ 1689.181491] Key type ._llcrypt registered [ 1689.182508] Key type .llcrypt registered [ 1689.435201] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1689.465062] alg: No test for adler32 (adler32-zlib) [ 1690.333332] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1690.418527] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 1691.999213] Key type lgssc registered [ 1692.497026] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1742.848168] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1744.499498] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1751.238954] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1761.788979] Lustre: Mounted lustre-client [ 1762.373436] LustreError: 75952:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902912b8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1762.380665] LustreError: 75952:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 1762.405143] Lustre: Unmounted lustre-client [ 1781.643866] Key type lgssc unregistered [ 1781.790411] LNet: 76355:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1781.795167] LNetError: 76355:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1781.806159] LNet: Removed LNI 192.168.203.45@tcp [ 1782.161951] Key type .llcrypt unregistered [ 1782.163301] Key type ._llcrypt unregistered [ 1787.987234] Key type ._llcrypt registered [ 1787.988696] Key type .llcrypt registered [ 1788.528608] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 19:35:51 (1760139351) [ 1789.448628] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1789.489158] alg: No test for adler32 (adler32-zlib) [ 1790.358622] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1790.450292] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 1792.047216] Key type lgssc registered [ 1792.447815] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1814.220369] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1815.908563] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1823.590631] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1834.490693] Lustre: Mounted lustre-client [ 1836.818726] LustreError: 79472:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028665e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1836.826615] LustreError: 79472:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 1836.849813] Lustre: Unmounted lustre-client [ 1837.013525] Lustre: Mounted lustre-client [ 1837.798690] LustreError: 79550:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902912b8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1837.805180] LustreError: 79550:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 1837.806968] LustreError: 79550:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1837.830186] Lustre: Unmounted lustre-client [ 1857.142785] Key type lgssc unregistered [ 1857.295648] LNet: 79951:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1857.300323] LNetError: 79951:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1857.311387] LNet: Removed LNI 192.168.203.45@tcp [ 1857.695940] Key type .llcrypt unregistered [ 1857.698129] Key type ._llcrypt unregistered [ 1862.835885] Key type ._llcrypt registered [ 1862.836791] Key type .llcrypt registered [ 1862.986783] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1862.996397] alg: No test for adler32 (adler32-zlib) [ 1863.847419] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1863.933618] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 1865.519238] Key type lgssc registered [ 1866.077863] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1889.391590] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1890.982765] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1899.877896] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1905.662158] Lustre: Mounted lustre-client [ 1907.684030] LustreError: 82484:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028978a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1907.694410] LustreError: 82484:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 1907.721237] Lustre: Unmounted lustre-client [ 1919.408173] Key type lgssc unregistered [ 1919.560576] LNet: 82886:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1919.564483] LNetError: 82886:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1919.577399] LNet: Removed LNI 192.168.203.45@tcp [ 1919.977191] Key type .llcrypt unregistered [ 1919.979377] Key type ._llcrypt unregistered [ 1926.851439] Key type ._llcrypt registered [ 1926.852833] Key type .llcrypt registered [ 1927.511300] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 19:38:10 (1760139490) [ 1928.445194] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1928.487117] alg: No test for adler32 (adler32-zlib) [ 1929.357234] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1929.440840] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 1931.015151] Key type lgssc registered [ 1931.598612] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1952.382859] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1954.079435] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1962.255540] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1972.732549] Lustre: Mounted lustre-client [ 1978.930857] Lustre: lustre: nosquash_nids is cleared [ 1978.941628] Lustre: lustre: root_squash is set to 500:500 [ 1985.467540] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.45@tcp 192.168.0.[2,10]@tcp [ 1992.119978] Lustre: lustre: nosquash_nids set to 192.168.203.45/24@tcp [ 1996.766189] LustreError: 86344:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990283032000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1996.773654] LustreError: 86344:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 1996.795200] Lustre: Unmounted lustre-client [ 2016.001662] Key type lgssc unregistered [ 2016.149058] LNet: 86747:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2016.153324] LNetError: 86747:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2016.165160] LNet: Removed LNI 192.168.203.45@tcp [ 2016.560165] Key type .llcrypt unregistered [ 2016.562269] Key type ._llcrypt unregistered [ 2022.970163] Key type ._llcrypt registered [ 2022.971207] Key type .llcrypt registered [ 2023.591004] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 19:39:46 (1760139586) [ 2024.541357] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 2025.334974] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 19:39:47 (1760139587) [ 2026.475771] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2026.496140] alg: No test for adler32 (adler32-zlib) [ 2027.385326] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2027.501745] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 2029.103157] Key type lgssc registered [ 2029.608386] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2049.677357] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2050.941143] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2059.099355] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2059.388126] Lustre: lustre: root_squash is set to 500:500 [ 2059.395979] Lustre: lustre: nosquash_nids set to 192.168.203.45/24@tcp [ 2070.010260] Lustre: Mounted lustre-client [ 2072.586089] LustreError: 90203:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028665f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2072.596850] LustreError: 90203:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2072.630064] Lustre: Unmounted lustre-client [ 2091.513376] Key type lgssc unregistered [ 2091.653470] LNet: 90605:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2091.655579] LNetError: 90605:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2091.663531] LNet: Removed LNI 192.168.203.45@tcp [ 2091.936122] Key type .llcrypt unregistered [ 2091.937114] Key type ._llcrypt unregistered [ 2097.517875] Key type ._llcrypt registered [ 2097.518950] Key type .llcrypt registered [ 2098.031637] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 2098.582441] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 19:41:01 (1760139661) [ 2105.090978] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2105.096210] alg: No test for adler32 (adler32-zlib) [ 2105.938414] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2106.011944] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 2107.591262] Key type lgssc registered [ 2108.161717] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2143.635432] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2145.279840] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2153.273919] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2191.977196] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2193.344387] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2201.410917] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2210.073130] Lustre: Mounted lustre-client [ 2225.995901] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff990285c7b000.ost_server_uuid 50 [ 2226.738720] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff990285c7b000.ost_server_uuid in FULL state after 0 sec [ 2226.942281] Lustre: Mounted lustre-client [ 2228.010197] LustreError: 97490:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902904a2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2228.021799] LustreError: 97490:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 2228.068645] Lustre: Unmounted lustre-client [ 2267.109329] Key type lgssc unregistered [ 2267.270725] LNet: 98061:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2267.275385] LNetError: 98061:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2267.287407] LNet: Removed LNI 192.168.203.45@tcp [ 2267.663639] Key type .llcrypt unregistered [ 2267.665629] Key type ._llcrypt unregistered [ 2285.963986] Key type ._llcrypt registered [ 2285.965102] Key type .llcrypt registered [ 2286.160479] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2286.173293] alg: No test for adler32 (adler32-zlib) [ 2287.045798] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2287.139679] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 2288.719174] Key type lgssc registered [ 2289.341502] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2327.629774] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2329.385781] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2339.279240] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2364.063983] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 19:45:26 (1760139926) [ 2405.689575] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2407.350389] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2416.981860] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2418.253289] Lustre: Mounted lustre-client [ 2438.627105] Lustre: lustre-MDT0000-mdc-ffff990292d99000: Connection to lustre-MDT0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2439.647190] Lustre: 98845:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139986/real 1760139986] req@00000000c7807697 x1845640403358848/t0(0) o400->lustre-OST0000-osc-ffff990292d99000@192.168.203.145@tcp:28/4 lens 224/224 e 0 to 1 dl 1760140002 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2444.767385] Lustre: 98844:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139991/real 1760139991] req@00000000725d35f8 x1845640403359360/t0(0) o400->lustre-OST0000-osc-ffff990292d99000@192.168.203.145@tcp:28/4 lens 224/224 e 0 to 1 dl 1760140007 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2448.863241] Lustre: 98845:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139996/real 1760139996] req@000000004764b864 x1845640403359872/t0(0) o400->lustre-OST0000-osc-ffff990292d99000@192.168.203.145@tcp:28/4 lens 224/224 e 0 to 1 dl 1760140012 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2453.983325] Lustre: 98845:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760140001/real 1760140001] req@000000000658eabe x1845640403360128/t0(0) o400->MGC192.168.203.145@tcp@192.168.203.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1760140017 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2453.987175] LustreError: MGC192.168.203.145@tcp: Connection to MGS (at 192.168.203.145@tcp) was lost; in progress operations using this service will fail [ 2454.013185] Lustre: 105969:0:(mgc_request.c:1910:mgc_process_log()) MGC192.168.203.145@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 2454.015157] Lustre: Evicted from MGS (at 192.168.203.145@tcp) after server handle changed from 0x7db0bb4dcfce0052 to 0x7db0bb4dcfce02eb [ 2454.026500] Lustre: MGC192.168.203.145@tcp: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 2457.645450] Lustre: lustre-MDT0000-mdc-ffff990292d99000: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 2458.087623] LustreError: 106691:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990292d99000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2458.096421] LustreError: 106691:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2458.129175] Lustre: Unmounted lustre-client [ 2477.390986] Key type lgssc unregistered [ 2477.551154] LNet: 107092:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2477.555890] LNetError: 107092:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2477.566920] LNet: Removed LNI 192.168.203.45@tcp [ 2477.966082] Key type .llcrypt unregistered [ 2477.968177] Key type ._llcrypt unregistered [ 2484.423655] Key type ._llcrypt registered [ 2484.425117] Key type .llcrypt registered [ 2485.145729] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 19:47:27 (1760140047) [ 2497.373743] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2497.387735] alg: No test for adler32 (adler32-zlib) [ 2498.314703] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2498.453275] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 2500.071112] Key type lgssc registered [ 2500.482819] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2518.181266] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2553.299608] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2554.859779] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2562.138676] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2563.293739] Lustre: Mounted lustre-client [ 2563.883384] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 2564.356873] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 19:48:47 (1760140127) [ 2607.345526] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2617.638083] LustreError: 117822:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2617.651907] Lustre: Unmounted lustre-client [ 2673.348270] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2675.119406] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2684.620901] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2708.340134] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:51:10 (1760140270) [ 2744.649609] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2746.195950] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2755.144976] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2760.687439] Lustre: Mounted lustre-client [ 2761.662071] LustreError: 125213:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990284aa3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2761.668540] LustreError: 125213:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2761.671876] LustreError: 125213:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2761.695159] Lustre: Unmounted lustre-client [ 2779.423937] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:52:22 (1760140342) [ 2809.488450] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2810.682304] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2817.307373] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2817.459205] Lustre: Mounted lustre-client [ 2818.370346] LustreError: 129249:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028665f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2818.375741] LustreError: 129249:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2818.377471] LustreError: 129249:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2818.396150] Lustre: Unmounted lustre-client [ 2835.128618] Key type lgssc unregistered [ 2835.248562] LNet: 129652:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2835.251238] LNetError: 129652:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2835.259502] LNet: Removed LNI 192.168.203.45@tcp [ 2835.491527] Key type .llcrypt unregistered [ 2835.492422] Key type ._llcrypt unregistered [ 2840.029477] Key type ._llcrypt registered [ 2840.030444] Key type .llcrypt registered [ 2840.456641] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 19:53:23 (1760140403) [ 2841.263877] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2841.279544] alg: No test for adler32 (adler32-zlib) [ 2842.137141] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2842.221182] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 2843.807134] Key type lgssc registered [ 2844.214646] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2860.116900] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2861.210408] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2866.536884] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2867.697265] Lustre: Mounted lustre-client [ 2878.375288] LustreError: 132745:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902912b8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2878.382567] LustreError: 132745:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2878.404178] Lustre: Unmounted lustre-client [ 2895.935463] Key type lgssc unregistered [ 2896.063533] LNet: 133148:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2896.065749] LNetError: 133148:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2896.075952] LNet: Removed LNI 192.168.203.45@tcp [ 2896.392796] Key type .llcrypt unregistered [ 2896.394405] Key type ._llcrypt unregistered [ 2900.847098] Key type ._llcrypt registered [ 2900.848482] Key type .llcrypt registered [ 2901.253369] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 19:54:24 (1760140464) [ 2901.916924] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2901.970895] alg: No test for adler32 (adler32-zlib) [ 2902.827014] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2902.911370] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 2904.495165] Key type lgssc registered [ 2904.830457] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2920.664395] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2921.776183] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2927.415568] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2928.568991] Lustre: Mounted lustre-client [ 2933.731235] Lustre: lustre-OST0000-osc-ffff990284843800: Connection to lustre-OST0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2939.269535] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff990284843800.ost_server_uuid 50 [ 2940.174220] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 2949.597583] LustreError: 136672:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990284843800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2949.602844] LustreError: 136672:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2949.622165] Lustre: Unmounted lustre-client [ 2960.248334] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 19:55:23 (1760140523) [ 2968.978815] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2969.989221] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2975.138203] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2982.707508] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 2982.884823] Lustre: Mounted lustre-client [ 2988.006867] Lustre: lustre-OST0000-osc-ffff99028712a800: Connection to lustre-OST0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3002.153651] LustreError: 139318:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028712a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3002.159985] LustreError: 139318:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3002.162186] LustreError: 139318:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3002.184454] Lustre: Unmounted lustre-client [ 3033.733672] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 19:56:36 (1760140596) [ 3043.430487] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3045.048415] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3053.438414] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3061.120403] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3061.290340] Lustre: Mounted lustre-client [ 3066.339748] Lustre: lustre-OST0000-osc-ffff990292d9f000: Connection to lustre-OST0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3077.866594] LustreError: 142071:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990292d9f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3077.869589] LustreError: 142071:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 3077.873663] LustreError: 142071:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3077.875060] LustreError: 142071:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3077.892140] Lustre: Unmounted lustre-client [ 3103.360720] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 19:57:46 (1760140666) [ 3131.172673] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3132.788422] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3142.662913] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3172.662586] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3173.728840] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3180.177696] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3191.318989] Lustre: Mounted lustre-client [ 3218.058965] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3218.592388] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3218.881288] LustreError: 148646:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028816c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3218.884315] LustreError: 148646:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 3218.888244] LustreError: 148646:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3218.889708] LustreError: 148646:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3218.906983] Lustre: Unmounted lustre-client [ 3233.427489] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 19:59:56 (1760140796) [ 3243.917969] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3245.056319] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3250.950585] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3270.468643] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3283.922626] Lustre: Mounted lustre-client [ 3310.993714] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3311.559662] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3314.659854] Lustre: lustre-OST0001-osc-ffff99028978d000: Connection to lustre-OST0001 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3319.158592] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3329.448753] LustreError: 152228:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3329.450291] LustreError: 152228:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3329.463581] Lustre: Unmounted lustre-client [ 3367.045847] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 20:02:09 (1760140929) [ 3376.120359] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3377.251759] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3382.951345] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3388.401404] Lustre: Mounted lustre-client [ 3395.095433] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3398.679885] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 3402.283512] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff99028665f000.ost_server_uuid 50 [ 3402.775855] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff99028665f000.ost_server_uuid in FULL state after 0 sec [ 3403.398705] LustreError: 155664:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028665f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3403.406660] LustreError: 155664:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3403.408619] LustreError: 155664:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3403.436165] Lustre: Unmounted lustre-client [ 3403.531615] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 3403.533185] Lustre: Skipped 3 previous similar messages [ 3403.925399] LustreError: 155729:0:(sec.c:410:import_sec_validate_get()) import 0000000050cf4e74 (NEW) with no sec [ 3442.424254] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 20:03:25 (1760141005) [ 3451.193493] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3452.199108] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3457.436644] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3462.974213] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3463.117509] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 3468.274110] Lustre: Mounted lustre-client [ 3468.275568] Lustre: Skipped 1 previous similar message [ 3473.634901] LustreError: 158551:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990292d98000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3473.638339] LustreError: 158551:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 3473.645650] LustreError: 158551:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3473.647198] LustreError: 158551:0:(obd_class.h:479:obd_check_dev()) Skipped 18 previous similar messages [ 3473.671651] Lustre: Unmounted lustre-client [ 3473.673044] Lustre: Skipped 1 previous similar message [ 3493.430220] Key type lgssc unregistered [ 3493.554668] LNet: 158997:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3493.556718] LNetError: 158997:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3493.567067] LNet: Removed LNI 192.168.203.45@tcp [ 3493.807308] Key type .llcrypt unregistered [ 3493.808636] Key type ._llcrypt unregistered [ 3498.283372] Key type ._llcrypt registered [ 3498.284431] Key type .llcrypt registered [ 3498.668365] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 20:04:21 (1760141061) [ 3499.016412] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3499.027148] alg: No test for adler32 (adler32-zlib) [ 3499.862243] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3499.931881] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 3501.503134] Key type lgssc registered [ 3501.831626] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3520.650860] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3522.508527] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3530.296422] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3537.229526] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3537.392231] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3538.438103] Lustre: Mounted lustre-client [ 3546.407847] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3546.885295] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 3553.638972] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 3559.580008] LustreError: 163199:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902a0444000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3559.586661] LustreError: 163199:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3559.609138] Lustre: Unmounted lustre-client [ 3578.463335] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 20:05:41 (1760141141) [ 3607.134959] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3608.213812] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3615.157569] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3615.322107] Lustre: Mounted lustre-client [ 3624.677960] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3625.224452] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3637.219248] Lustre: lustre-OST0001-osc-ffff9902868c4800: Connection to lustre-OST0001 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3643.516895] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3653.798206] LustreError: 167920:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3653.800526] LustreError: 167920:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3653.816115] Lustre: Unmounted lustre-client [ 3676.935201] Key type lgssc unregistered [ 3677.049552] LNet: 168324:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3677.051586] LNetError: 168324:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3677.061760] LNet: Removed LNI 192.168.203.45@tcp [ 3677.284955] Key type .llcrypt unregistered [ 3677.285987] Key type ._llcrypt unregistered [ 3690.438157] Key type ._llcrypt registered [ 3690.439310] Key type .llcrypt registered [ 3690.665115] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3690.670536] alg: No test for adler32 (adler32-zlib) [ 3691.515035] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3691.593818] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 3693.175111] Key type lgssc registered [ 3693.511544] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3719.938578] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3720.970758] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3727.785629] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3756.398585] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 20:08:39 (1760141319) [ 3765.018673] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3766.039335] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3771.501753] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3772.661461] Lustre: Mounted lustre-client [ 3809.109116] LustreError: 174384:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99028816e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3809.117076] LustreError: 174384:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3809.138108] Lustre: Unmounted lustre-client [ 3825.661662] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3825.870696] Lustre: Mounted lustre-client [ 3858.260444] LustreError: 175041:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990284c22000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3858.268686] LustreError: 175041:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3858.270095] LustreError: 175041:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3858.288436] Lustre: Unmounted lustre-client [ 3875.577549] Key type lgssc unregistered [ 3875.709478] LNet: 175448:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3875.711460] LNetError: 175448:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3875.718930] LNet: Removed LNI 192.168.203.45@tcp [ 3875.966744] Key type .llcrypt unregistered [ 3875.967896] Key type ._llcrypt unregistered [ 3880.898514] Key type ._llcrypt registered [ 3880.899385] Key type .llcrypt registered [ 3881.353705] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 20:10:44 (1760141444) [ 3882.140347] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3882.187287] alg: No test for adler32 (adler32-zlib) [ 3883.043255] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3883.130599] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 3884.727203] Key type lgssc registered [ 3885.165931] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3903.738964] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3904.837536] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3910.509870] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3920.881796] Lustre: Mounted lustre-client [ 3927.019025] LustreError: 178699:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990288b22000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3927.025272] LustreError: 178699:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3927.046240] Lustre: Unmounted lustre-client [ 3944.022804] Key type lgssc unregistered [ 3944.142332] LNet: 179102:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3944.144443] LNetError: 179102:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3944.153559] LNet: Removed LNI 192.168.203.45@tcp [ 3944.393768] Key type .llcrypt unregistered [ 3944.394720] Key type ._llcrypt unregistered [ 3948.466100] Key type ._llcrypt registered [ 3948.467029] Key type .llcrypt registered [ 3948.619181] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3948.631715] alg: No test for adler32 (adler32-zlib) [ 3949.480872] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3949.561475] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 3951.143138] Key type lgssc registered [ 3951.512220] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3968.037618] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3969.209189] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3974.853301] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3990.511370] Lustre: Mounted lustre-client [ 3993.215934] LustreError: 181663:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990288183000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3993.222608] LustreError: 181663:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3993.241136] Lustre: Unmounted lustre-client [ 4010.247855] Key type lgssc unregistered [ 4010.367692] LNet: 182065:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4010.370354] LNetError: 182065:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4010.380380] LNet: Removed LNI 192.168.203.45@tcp [ 4010.630531] Key type .llcrypt unregistered [ 4010.632285] Key type ._llcrypt unregistered [ 4015.822680] Key type ._llcrypt registered [ 4015.823634] Key type .llcrypt registered [ 4016.246103] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 20:12:59 (1760141579) [ 4016.898841] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4016.920448] alg: No test for adler32 (adler32-zlib) [ 4017.763812] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4017.840406] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 4019.423111] Key type lgssc registered [ 4019.780000] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4035.927833] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4037.051279] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4042.926344] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4058.608886] Lustre: Mounted lustre-client [ 4064.879896] LustreError: 185311:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902900fd800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4064.886307] LustreError: 185311:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4064.905177] Lustre: Unmounted lustre-client [ 4081.777167] Key type lgssc unregistered [ 4081.894550] LNet: 185713:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4081.896853] LNetError: 185713:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4081.903605] LNet: Removed LNI 192.168.203.45@tcp [ 4082.144882] Key type .llcrypt unregistered [ 4082.145758] Key type ._llcrypt unregistered [ 4086.345782] Key type ._llcrypt registered [ 4086.346677] Key type .llcrypt registered [ 4086.535639] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4086.541503] alg: No test for adler32 (adler32-zlib) [ 4087.395997] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4087.476348] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 4089.055142] Key type lgssc registered [ 4089.424266] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4105.560924] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4106.651109] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4112.051490] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4113.209346] Lustre: Mounted lustre-client [ 4115.694243] LustreError: 188273:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902912b9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4115.701564] LustreError: 188273:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4115.722575] Lustre: Unmounted lustre-client [ 4132.614713] Key type lgssc unregistered [ 4132.721456] LNet: 188674:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4132.725176] LNetError: 188674:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4132.733590] LNet: Removed LNI 192.168.203.45@tcp [ 4132.939801] Key type .llcrypt unregistered [ 4132.941031] Key type ._llcrypt unregistered [ 4138.174524] Key type ._llcrypt registered [ 4138.175482] Key type .llcrypt registered [ 4138.600413] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 20:15:01 (1760141701) [ 4145.839898] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4145.844596] alg: No test for adler32 (adler32-zlib) [ 4146.698919] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4146.781052] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 4148.359112] Key type lgssc registered [ 4148.691395] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4175.380145] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4176.519935] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4185.767998] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4211.374727] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 20:16:13 (1760141773) [ 4225.106693] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4226.814457] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4235.436143] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4240.894147] Lustre: Mounted lustre-client [ 4243.170952] LustreError: 195170:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902900fe000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4243.180103] LustreError: 195170:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4243.205168] Lustre: Unmounted lustre-client [ 4270.723475] Key type lgssc unregistered [ 4270.865137] LNet: 195573:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4270.869385] LNetError: 195573:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4270.879420] LNet: Removed LNI 192.168.203.45@tcp [ 4271.270257] Key type .llcrypt unregistered [ 4271.272340] Key type ._llcrypt unregistered [ 4278.017392] Key type ._llcrypt registered [ 4278.018379] Key type .llcrypt registered [ 4278.627642] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 4279.475488] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 20:17:21 (1760141841) [ 4286.821891] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4286.832719] alg: No test for adler32 (adler32-zlib) [ 4287.730953] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4287.825141] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 4289.415097] Key type lgssc registered [ 4289.840145] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4332.461758] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4334.212378] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4343.790967] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 4352.773548] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 4353.990147] Lustre: Mounted lustre-client [ 4362.737470] LustreError: 201101:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902886ca000: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 4362.745157] LustreError: 201101:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4362.767712] Lustre: Unmounted lustre-client [ 4439.343370] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4441.165801] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4451.849057] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4485.567729] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 20:20:48 (1760142048) [ 4486.338736] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 4487.007355] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 20:20:49 (1760142049) [ 4509.402738] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4511.179372] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4528.019775] Key type lgssc unregistered [ 4528.175376] LNet: 207265:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4528.180181] LNetError: 207265:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4528.191109] LNet: Removed LNI 192.168.203.45@tcp [ 4528.572070] Key type .llcrypt unregistered [ 4528.573357] Key type ._llcrypt unregistered [ 4535.021351] Key type ._llcrypt registered [ 4535.022390] Key type .llcrypt registered [ 4535.555387] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 20:21:38 (1760142098) [ 4550.305194] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4550.342303] alg: No test for adler32 (adler32-zlib) [ 4551.241564] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4551.366723] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 4552.983226] Key type lgssc registered [ 4553.570127] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4574.180391] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4575.764734] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4584.231396] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4597.865640] Key type lgssc unregistered [ 4598.029595] LNet: 210890:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4598.033884] LNetError: 210890:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4598.043784] LNet: Removed LNI 192.168.203.45@tcp [ 4598.465688] Key type .llcrypt unregistered [ 4598.467782] Key type ._llcrypt unregistered [ 4605.422432] Key type ._llcrypt registered [ 4605.423839] Key type .llcrypt registered [ 4606.024530] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 20:22:48 (1760142168) [ 4607.081036] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4607.102435] alg: No test for adler32 (adler32-zlib) [ 4608.006698] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4608.108535] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 4609.719175] Key type lgssc registered [ 4610.385381] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4632.267307] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4634.098560] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4642.368342] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4653.052350] Lustre: Mounted lustre-client [ 4658.149380] Lustre: lustre-MDT0000-mdc-ffff990284c24000: Connection to lustre-MDT0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4663.266935] Lustre: lustre-MDT0001-mdc-ffff990284c24000: Connection to lustre-MDT0001 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4678.626304] LustreError: MGC192.168.203.145@tcp: Connection to MGS (at 192.168.203.145@tcp) was lost; in progress operations using this service will fail [ 4678.637361] Lustre: Evicted from MGS (at 192.168.203.145@tcp) after server handle changed from 0x1244e38a18b4c438 to 0x1244e38a18b4dd7c [ 4678.644250] Lustre: MGC192.168.203.145@tcp: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 4697.062601] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4698.659909] LustreError: lustre-MDT0000-mdc-ffff990284c24000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 4698.687165] Lustre: lustre-MDT0000-mdc-ffff990284c24000: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 4699.915374] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 2 sec [ 4701.437837] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4702.203575] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4702.873572] LustreError: 215304:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990284c24000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4702.877595] LustreError: 215304:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4702.894380] Lustre: Unmounted lustre-client [ 4721.911974] Key type lgssc unregistered [ 4722.068792] LNet: 215706:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4722.073450] LNetError: 215706:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4722.084383] LNet: Removed LNI 192.168.203.45@tcp [ 4722.472459] Key type .llcrypt unregistered [ 4722.474557] Key type ._llcrypt unregistered [ 4728.966775] Key type ._llcrypt registered [ 4728.968583] Key type .llcrypt registered [ 4729.666623] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 20:24:52 (1760142292) [ 4730.757226] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4730.762035] alg: No test for adler32 (adler32-zlib) [ 4731.628486] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4731.729101] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 4733.327101] Key type lgssc registered [ 4733.717565] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4757.249233] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4758.913447] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4786.687349] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4788.406542] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4801.446859] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4810.867641] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4839.284626] Key type lgssc unregistered [ 4839.468815] LNet: 220808:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4839.473238] LNetError: 220808:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4839.486775] LNet: Removed LNI 192.168.203.45@tcp [ 4839.869673] Key type .llcrypt unregistered [ 4839.871744] Key type ._llcrypt unregistered [ 4859.444747] Key type ._llcrypt registered [ 4859.446542] Key type .llcrypt registered [ 4859.684147] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4859.689296] alg: No test for adler32 (adler32-zlib) [ 4860.608980] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4860.730922] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 4862.351151] Key type lgssc registered [ 4863.046135] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4904.113797] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4905.763252] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4916.036626] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4940.776588] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 20:28:23 (1760142503) [ 4992.797787] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4994.612479] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5005.082474] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5030.521577] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 20:29:53 (1760142593) [ 5034.121829] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 20:29:56 (1760142596) [ 5048.903885] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5050.728271] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5059.501738] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5066.213366] Lustre: Mounted lustre-client [ 5073.674722] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 5074.836169] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 5075.637964] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 5076.566443] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 5081.571522] Lustre: lustre-MDT0000-mdc-ffff9902904a3800: Connection to lustre-MDT0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5096.927171] Lustre: 221593:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760142644/real 1760142644] req@00000000aa5faaf3 x1845643101349888/t0(0) o400->MGC192.168.203.145@tcp@192.168.203.145@tcp:26/25 lens 224/224 e 0 to 1 dl 1760142660 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5096.933460] LustreError: MGC192.168.203.145@tcp: Connection to MGS (at 192.168.203.145@tcp) was lost; in progress operations using this service will fail [ 5096.957936] Lustre: Evicted from MGS (at 192.168.203.145@tcp) after server handle changed from 0x9fd15e637ed71e7c to 0x9fd15e637ed720eb [ 5096.964781] Lustre: MGC192.168.203.145@tcp: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 5097.518344] Lustre: lustre-MDT0000-mdc-ffff9902904a3800: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 5099.320887] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5100.212598] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5102.558961] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 5107.173552] Lustre: lustre-MDT0000-mdc-ffff9902904a3800: Connection to lustre-MDT0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5120.479196] Lustre: 231968:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760142667/real 1760142667] req@0000000055c12755 x1845643101355008/t0(0) o101->MGC192.168.203.145@tcp@192.168.203.145@tcp:26/25 lens 328/344 e 0 to 1 dl 1760142683 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5120.501086] LustreError: MGC192.168.203.145@tcp: Connection to MGS (at 192.168.203.145@tcp) was lost; in progress operations using this service will fail [ 5120.512522] Lustre: 231968:0:(mgc_request.c:1910:mgc_process_log()) MGC192.168.203.145@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 5120.514559] Lustre: Evicted from MGS (at 192.168.203.145@tcp) after server handle changed from 0x9fd15e637ed720eb to 0x9fd15e637ed723d1 [ 5120.525854] Lustre: MGC192.168.203.145@tcp: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 5123.124496] Lustre: lustre-MDT0000-mdc-ffff9902904a3800: Connection restored to 192.168.203.145@tcp (at 192.168.203.145@tcp) [ 5124.928303] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5125.744271] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5127.525615] LustreError: 234408:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902904a3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5127.533218] LustreError: 234408:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5127.553408] Lustre: Unmounted lustre-client [ 5167.631609] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5169.315138] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5178.055879] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5183.487732] Lustre: Mounted lustre-client [ 5183.946001] LustreError: 236027:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990298e99000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5183.955073] LustreError: 236027:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5183.958447] LustreError: 236027:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5183.992789] Lustre: Unmounted lustre-client [ 5203.277587] Key type lgssc unregistered [ 5203.451731] LNet: 236429:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5203.456550] LNetError: 236429:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5203.470860] LNet: Removed LNI 192.168.203.45@tcp [ 5203.881183] Key type .llcrypt unregistered [ 5203.883070] Key type ._llcrypt unregistered [ 5210.817674] Key type ._llcrypt registered [ 5210.819514] Key type .llcrypt registered [ 5211.564778] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 20:32:53 (1760142773) [ 5213.568753] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5213.588899] alg: No test for adler32 (adler32-zlib) [ 5214.514576] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 5214.642225] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 5216.263195] Key type lgssc registered [ 5216.899973] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5241.226591] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5243.021880] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5251.918229] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5257.214467] Lustre: Mounted lustre-client [ 5260.613414] LustreError: 239597:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902876ee800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5260.622400] LustreError: 239597:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5260.655242] Lustre: Unmounted lustre-client [ 5299.206423] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5301.027720] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5310.023748] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5315.590182] Lustre: Mounted lustre-client [ 5321.903581] LustreError: 241195:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902872f1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5321.909279] LustreError: 241195:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5321.911033] LustreError: 241195:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5321.930244] Lustre: Unmounted lustre-client [ 5360.425373] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5362.190906] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5370.949076] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5376.510769] Lustre: Mounted lustre-client [ 5376.958240] LustreError: 242810:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902900fb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5376.965929] LustreError: 242810:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5376.968536] LustreError: 242810:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5376.993135] Lustre: Unmounted lustre-client [ 5396.422258] Key type lgssc unregistered [ 5396.571275] LNet: 243214:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5396.575930] LNetError: 243214:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5396.586815] LNet: Removed LNI 192.168.203.45@tcp [ 5396.986485] Key type .llcrypt unregistered [ 5396.988587] Key type ._llcrypt unregistered [ 5403.784929] Key type ._llcrypt registered [ 5403.785997] Key type .llcrypt registered [ 5404.524519] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 20:36:06 (1760142966) [ 5406.022482] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5406.066766] alg: No test for adler32 (adler32-zlib) [ 5406.985992] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 5407.108613] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 5408.719195] Key type lgssc registered [ 5409.344930] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5431.518326] Key type lgssc unregistered [ 5431.695607] LNet: 245525:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5431.699956] LNetError: 245525:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5431.710757] LNet: Removed LNI 192.168.203.45@tcp [ 5432.117813] Key type .llcrypt unregistered [ 5432.119903] Key type ._llcrypt unregistered [ 5445.309180] Key type ._llcrypt registered [ 5445.310273] Key type .llcrypt registered [ 5445.523432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5445.527862] alg: No test for adler32 (adler32-zlib) [ 5446.426379] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 5446.554740] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 5448.175202] Key type lgssc registered [ 5448.775991] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5489.249458] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5491.169308] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5501.819543] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5535.416269] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 5536.246454] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 20:38:18 (1760143098) [ 5549.924160] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5551.731284] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5560.494270] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5570.697615] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5571.993829] Lustre: Mounted lustre-client [ 5577.187645] Lustre: lustre-OST0001-osc-ffff990292d9c800: Connection to lustre-OST0001 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5580.330427] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5590.572975] LustreError: 252012:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 5590.604574] Lustre: Unmounted lustre-client [ 5625.028094] Key type lgssc unregistered [ 5625.210952] LNet: 252418:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5625.215955] LNetError: 252418:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5625.229810] LNet: Removed LNI 192.168.203.45@tcp [ 5625.638989] Key type .llcrypt unregistered [ 5625.641131] Key type ._llcrypt unregistered [ 5646.205498] Key type ._llcrypt registered [ 5646.206496] Key type .llcrypt registered [ 5646.426923] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5646.450484] alg: No test for adler32 (adler32-zlib) [ 5647.364912] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 5647.487447] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 5649.103216] Key type lgssc registered [ 5649.765656] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5690.473928] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5692.361868] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5702.385590] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5734.962386] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 20:41:37 (1760143297) [ 5754.125352] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5755.921928] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5769.403278] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 20:42:12 (1760143332) [ 5783.232719] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5784.302666] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5792.810460] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5798.396850] Lustre: Mounted lustre-client [ 5810.150851] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5811.863835] LustreError: 260284:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5811.880925] Lustre: Unmounted lustre-client [ 5859.229567] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5861.028943] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5899.803184] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5910.533300] Lustre: Mounted lustre-client [ 5911.163755] LustreError: 262376:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990286d49000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5911.174322] LustreError: 262376:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5911.177134] LustreError: 262376:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5911.210178] Lustre: Unmounted lustre-client [ 5928.606905] Key type lgssc unregistered [ 5928.720562] LNet: 262779:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5928.722823] LNetError: 262779:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5928.730762] LNet: Removed LNI 192.168.203.45@tcp [ 5928.939510] Key type .llcrypt unregistered [ 5928.940921] Key type ._llcrypt unregistered [ 5937.036352] Key type ._llcrypt registered [ 5937.037525] Key type .llcrypt registered [ 5937.212773] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5937.220300] alg: No test for adler32 (adler32-zlib) [ 5938.075869] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 5938.155089] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 5939.735151] Key type lgssc registered [ 5940.100526] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5966.087683] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5967.118282] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5973.730252] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6002.757979] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 6003.240678] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 20:46:06 (1760143566) [ 6011.572657] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6012.688236] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6021.214564] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6023.746462] Lustre: Mounted lustre-client [ 6024.687391] LustreError: 268807:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990288183800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6024.696960] LustreError: 268807:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6024.732321] Lustre: Unmounted lustre-client [ 6041.590230] Key type lgssc unregistered [ 6041.704374] LNet: 269209:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6041.706361] LNetError: 269209:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6041.717602] LNet: Removed LNI 192.168.203.45@tcp [ 6041.958429] Key type .llcrypt unregistered [ 6041.959386] Key type ._llcrypt unregistered [ 6046.610313] Key type ._llcrypt registered [ 6046.611291] Key type .llcrypt registered [ 6046.992941] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 6047.450256] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 20:46:50 (1760143610) [ 6050.183269] Key type .llcrypt unregistered [ 6050.184324] Key type ._llcrypt unregistered [ 6052.760750] Key type ._llcrypt registered [ 6052.762387] Key type .llcrypt registered [ 6052.944404] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6052.948571] alg: No test for adler32 (adler32-zlib) [ 6053.795261] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6053.875889] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6055.447160] Key type lgssc registered [ 6055.768995] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6072.262423] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6077.426828] Lustre: Mounted lustre-client [ 6077.818644] LustreError: 272214:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99029158c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6077.823901] LustreError: 272214:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6077.840917] Lustre: Unmounted lustre-client [ 6096.273304] Key type lgssc unregistered [ 6096.399561] LNet: 272617:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6096.403937] LNetError: 272617:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6096.413817] LNet: Removed LNI 192.168.203.45@tcp [ 6096.675014] Key type .llcrypt unregistered [ 6096.676202] Key type ._llcrypt unregistered [ 6103.606172] Key type ._llcrypt registered [ 6103.607748] Key type .llcrypt registered [ 6104.325584] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 20:47:46 (1760143666) [ 6105.323410] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6105.379588] alg: No test for adler32 (adler32-zlib) [ 6106.254563] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6106.333552] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6107.919130] Key type lgssc registered [ 6108.465866] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6170.322212] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6178.960785] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6180.019865] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6185.457461] Lustre: Mounted lustre-client [ 6185.876676] LustreError: 275655:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902904a1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6185.882880] LustreError: 275655:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6185.900827] Lustre: Unmounted lustre-client [ 6202.745709] Key type lgssc unregistered [ 6202.870390] LNet: 276057:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6202.872666] LNetError: 276057:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6202.882553] LNet: Removed LNI 192.168.203.45@tcp [ 6203.108871] Key type .llcrypt unregistered [ 6203.109786] Key type ._llcrypt unregistered [ 6208.157833] Key type ._llcrypt registered [ 6208.158727] Key type .llcrypt registered [ 6208.590284] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 20:49:31 (1760143771) [ 6209.329449] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6209.389523] alg: No test for adler32 (adler32-zlib) [ 6210.248435] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6210.326883] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6211.911134] Key type lgssc registered [ 6212.287538] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6227.932363] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6228.988905] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6234.338345] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6235.488802] Lustre: Mounted lustre-client [ 6240.738153] Lustre: lustre-MDT0000-mdc-ffff990282f56800: Connection to lustre-MDT0000 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6242.800685] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6242.808786] LustreError: 279114:0:(file.c:6101:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 6242.904115] LustreError: 279133:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990282f56800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6242.905924] LustreError: MGC192.168.203.145@tcp: Connection to MGS (at 192.168.203.145@tcp) was lost; in progress operations using this service will fail [ 6242.909492] LustreError: 279133:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6242.927376] Lustre: Unmounted lustre-client [ 6252.948791] Key type lgssc unregistered [ 6253.060462] LNet: 279528:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6253.062528] LNetError: 279528:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6253.072396] LNet: Removed LNI 192.168.203.45@tcp [ 6253.282332] Key type .llcrypt unregistered [ 6253.283333] Key type ._llcrypt unregistered [ 6257.418854] Key type ._llcrypt registered [ 6257.419720] Key type .llcrypt registered [ 6257.799731] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 20:50:20 (1760143820) [ 6258.522162] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6258.563715] alg: No test for adler32 (adler32-zlib) [ 6259.402131] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6259.468756] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6261.039103] Key type lgssc registered [ 6261.327867] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6280.057539] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6281.572628] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6290.156169] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6300.669234] Lustre: Mounted lustre-client [ 6305.763969] Lustre: lustre-MDT0001-mdc-ffff9902904a0800: Connection to lustre-MDT0001 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6309.086778] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6309.568773] LustreError: 282621:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9902904a0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6309.575822] LustreError: 282621:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6309.595351] Lustre: Unmounted lustre-client [ 6322.871905] Key type lgssc unregistered [ 6323.043199] LNet: 283014:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6323.047909] LNetError: 283014:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6323.058709] LNet: Removed LNI 192.168.203.45@tcp [ 6323.435477] Key type .llcrypt unregistered [ 6323.437641] Key type ._llcrypt unregistered [ 6330.584125] Key type ._llcrypt registered [ 6330.586224] Key type .llcrypt registered [ 6331.350917] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 20:51:33 (1760143893) [ 6340.183726] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6340.193095] alg: No test for adler32 (adler32-zlib) [ 6341.122987] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6341.253962] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6342.855221] Key type lgssc registered [ 6343.511381] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6384.523563] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6385.659789] Lustre: Mounted lustre-client [ 6402.530166] Lustre: lustre-MDT0001-mdc-ffff9902904a5000: Connection to lustre-MDT0001 (at 192.168.203.145@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6405.355438] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6415.591677] LustreError: 288349:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 6415.604180] Lustre: Unmounted lustre-client [ 6432.019707] Key type lgssc unregistered [ 6432.129481] LNet: 288750:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6432.131287] LNetError: 288750:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6432.142616] LNet: Removed LNI 192.168.203.45@tcp [ 6432.350301] Key type .llcrypt unregistered [ 6432.351153] Key type ._llcrypt unregistered [ 6436.988071] Key type ._llcrypt registered [ 6436.988976] Key type .llcrypt registered [ 6437.434648] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 20:53:20 (1760144000) [ 6438.265474] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 6439.166873] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 20:53:21 (1760144001) [ 6440.011409] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 6440.814358] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 20:53:23 (1760144003) [ 6441.699296] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 6442.561645] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 20:53:25 (1760144005) [ 6443.465621] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 6444.358771] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 20:53:26 (1760144006) [ 6445.164906] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 6445.996637] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 20:53:28 (1760144008) [ 6450.419332] Key type .llcrypt unregistered [ 6450.421346] Key type ._llcrypt unregistered [ 6452.765768] Key type ._llcrypt registered [ 6452.766648] Key type .llcrypt registered [ 6452.911095] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6452.918267] alg: No test for adler32 (adler32-zlib) [ 6453.757104] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6453.829224] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6455.407089] Key type lgssc registered [ 6455.715318] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6478.985185] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6480.011792] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6486.665749] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6487.854968] Lustre: Mounted lustre-client [ 6488.255750] LustreError: 294326:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990290c23800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6488.261683] LustreError: 294326:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6488.287266] Lustre: Unmounted lustre-client [ 6513.171403] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 20:54:35 (1760144075) [ 6526.068929] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6527.565242] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6534.222306] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6544.880573] Lustre: Mounted lustre-client [ 6545.159903] LustreError: 296439:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990291588800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6545.165646] LustreError: 296439:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6545.167116] LustreError: 296439:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 6545.185467] Lustre: Unmounted lustre-client [ 6554.962218] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 20:55:17 (1760144117) [ 6578.412222] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6579.469143] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6584.704279] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6630.720464] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 20:56:33 (1760144193) [ 6636.432801] Key type lgssc unregistered [ 6636.591658] LNet: 301876:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6636.596390] LNetError: 301876:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6665.319585] LNet: Removed LNI 192.168.203.45@tcp [ 6665.698671] Key type .llcrypt unregistered [ 6665.700755] Key type ._llcrypt unregistered [ 6798.522319] Key type ._llcrypt registered [ 6798.523245] Key type .llcrypt registered [ 6798.731411] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6798.739864] alg: No test for adler32 (adler32-zlib) [ 6799.620291] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6799.721194] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6801.327175] Key type lgssc registered [ 6802.006144] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6811.164180] Lustre: DEBUG MARKER: SKIP: conf-sanity test_73c unable to configure net [ 6816.429534] Key type lgssc unregistered [ 6816.601565] LNet: 303560:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6816.603449] LNetError: 303560:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6816.614388] LNet: Removed LNI 192.168.203.45@tcp [ 6816.962837] Key type .llcrypt unregistered [ 6816.964840] Key type ._llcrypt unregistered [ 6820.982670] Key type ._llcrypt registered [ 6820.984435] Key type .llcrypt registered [ 6821.719639] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 20:59:44 (1760144384) [ 6830.097400] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6830.106677] alg: No test for adler32 (adler32-zlib) [ 6831.009659] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6831.128560] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6832.735157] Key type lgssc registered [ 6833.380518] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6855.104502] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 21:00:17 (1760144417) [ 6860.338494] Key type lgssc unregistered [ 6860.449679] LNet: 307103:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6860.452582] LNetError: 307103:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6860.461911] LNet: Removed LNI 192.168.203.45@tcp [ 6860.678647] Key type .llcrypt unregistered [ 6860.679925] Key type ._llcrypt unregistered [ 6864.815168] Key type ._llcrypt registered [ 6864.816205] Key type .llcrypt registered [ 6865.010696] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6865.015185] alg: No test for adler32 (adler32-zlib) [ 6865.863948] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6865.944040] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6867.519170] Key type lgssc registered [ 6868.198702] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6893.440380] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6895.097149] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6905.178270] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6910.428684] LNet: Added LNI 192.168.203.45@tcp42 [8/256/0/180] [ 6911.471676] LNet: Removed LNI 192.168.203.45@tcp [ 6912.888830] Lustre: 310007:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff990284c22000: config has no valid NIDs, force dynamic NIDs [ 6913.958454] Lustre: Mounted lustre-client [ 6913.984098] LustreError: 310022:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990284c22000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6913.991254] LustreError: 310022:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6914.019081] Lustre: Unmounted lustre-client [ 6935.798455] Key type lgssc unregistered [ 6935.984769] LNet: 310860:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6935.989471] LNetError: 310860:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6936.000085] LNet: Removed LNI 192.168.203.45@tcp42 [ 6936.331546] Key type .llcrypt unregistered [ 6936.333620] Key type ._llcrypt unregistered [ 6940.666648] Key type ._llcrypt registered [ 6940.667871] Key type .llcrypt registered [ 6941.301262] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 21:01:43 (1760144503) [ 6942.316737] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6942.322886] alg: No test for adler32 (adler32-zlib) [ 6943.188258] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 6943.289836] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 6944.895222] Key type lgssc registered [ 6945.440726] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6968.239238] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6969.945526] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6978.742230] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6984.189731] Lustre: Mounted lustre-client [ 7011.833476] Lustre: Mounted fs15246-client [ 7018.581136] LustreError: 314991:0:(lov_obd.c:783:lov_cleanup()) fs15246-clilov-ffff99028735e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7018.592299] LustreError: 314991:0:(obd_class.h:479:obd_check_dev()) Device 8 not setup [ 7018.613541] Lustre: Unmounted fs15246-client [ 7033.712205] LustreError: 315209:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff990286b1c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7033.718083] LustreError: 315209:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7033.721434] LustreError: 315209:0:(obd_class.h:479:obd_check_dev()) Skipped 3 previous similar messages [ 7033.754587] Lustre: Unmounted lustre-client [ 7052.909426] Key type lgssc unregistered [ 7053.085706] LNet: 315611:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7053.090355] LNetError: 315611:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7053.101711] LNet: Removed LNI 192.168.203.45@tcp [ 7053.454129] Key type .llcrypt unregistered [ 7053.456054] Key type ._llcrypt unregistered [ 7057.881171] Key type ._llcrypt registered [ 7057.882136] Key type .llcrypt registered [ 7058.471801] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 21:03:41 (1760144621) [ 7059.179653] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7059.188349] alg: No test for adler32 (adler32-zlib) [ 7060.076694] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 7060.182826] LNet: Added LNI 192.168.203.45@tcp [8/256/0/180] [ 7061.775169] Key type lgssc registered [ 7062.367840] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7125.255478] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7127.128636] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7137.765556] Lustre: DEBUG MARKER: oleg345-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7196.346500] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 7057 sec ========== 21:05:58 (1760144758) [ 7197.218412] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 21:05:59 (1760144759) === [ 7198.903526] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 21:06:01 (1760144761) === [ 7215.523576] Key type lgssc unregistered [ 7215.699778] LNet: 324754:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7215.704552] LNetError: 324754:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7215.723705] LNet: Removed LNI 192.168.203.45@tcp [ 7216.128588] Key type .llcrypt unregistered [ 7216.130614] Key type ._llcrypt unregistered