[ 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 472276741 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: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003093] x2apic enabled [ 0.004005] Switched APIC routing to physical x2apic. [ 0.005013] kvm-guest: setup PV IPIs [ 0.007759] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 0.008046] Calibrating delay loop (skipped) preset value.. 4800.00 BogoMIPS (lpj=2400000) [ 0.009008] pid_max: default: 32768 minimum: 301 [ 0.010223] LSM: Security Framework initializing [ 0.011045] Yama: becoming mindful. [ 0.012025] SELinux: Initializing. [ 0.013045] *** VALIDATE selinux *** [ 0.020695] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024683] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025134] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026072] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027099] *** VALIDATE tmpfs *** [ 0.028485] *** VALIDATE proc *** [ 0.029179] *** VALIDATE cgroup *** [ 0.030004] *** VALIDATE cgroup2 *** [ 0.031175] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.032136] 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.034022] Spectre V2 : User space: Vulnerable [ 0.035003] Speculative Store Bypass: Vulnerable [ 0.038239] debug: unmapping init [mem 0xffffffff92059000-0xffffffff92060fff] [ 0.040808] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.041675] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.042015] ... version: 2 [ 0.043008] ... bit width: 48 [ 0.044005] ... generic registers: 4 [ 0.044830] ... value mask: 0000ffffffffffff [ 0.045006] ... max period: 00007fffffffffff [ 0.046008] ... fixed-purpose events: 3 [ 0.047019] ... event mask: 000000070000000f [ 0.048350] rcu: Hierarchical SRCU implementation. [ 0.050521] smp: Bringing up secondary CPUs ... [ 0.051556] x86: Booting SMP configuration: [ 0.052013] .... node #0, CPUs: #1 #2 #3 [ 0.056187] smp: Brought up 1 node, 4 CPUs [ 0.058017] smpboot: Max logical packages: 1 [ 0.059012] smpboot: Total of 4 processors activated (19200.00 BogoMIPS) [ 0.193294] node 0 deferred pages initialised in 133ms [ 0.196133] devtmpfs: initialized [ 0.197228] x86/mm: Memory block size: 128MB [ 0.199643] gcov: version magic: 0x41383552 [ 0.200590] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.203114] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.205292] pinctrl core: initialized pinctrl subsystem [ 0.207127] [ 0.207630] ************************************************************* [ 0.209010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.211006] ** ** [ 0.213011] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.215011] ** ** [ 0.218009] ** This means that this kernel is built to expose internal ** [ 0.220009] ** IOMMU data structures, which may compromise security on ** [ 0.221010] ** your system. ** [ 0.224011] ** ** [ 0.225007] ** If you see this message and you are not debugging the ** [ 0.227011] ** kernel, report this immediately to your vendor! ** [ 0.229011] ** ** [ 0.230009] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.232008] ************************************************************* [ 0.234593] NET: Registered protocol family 16 [ 0.235383] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.238055] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.240032] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.243434] cpuidle: using governor menu [ 0.246529] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.249557] PCI: Using configuration type 1 for base access [ 0.251145] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.258152] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.259029] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.260218] cryptd: max_cpu_qlen set to 1000 [ 0.262460] ACPI: Added _OSI(Module Device) [ 0.264011] ACPI: Added _OSI(Processor Device) [ 0.265011] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.266007] ACPI: Added _OSI(Processor Aggregator Device) [ 0.270168] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.274393] ACPI: Interpreter enabled [ 0.276059] ACPI: PM: (supports S0 S3 S4 S5) [ 0.276965] ACPI: Using IOAPIC for interrupt routing [ 0.278076] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.281264] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.290143] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.292031] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.294009] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.296060] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.300160] acpiphp: Slot [2] registered [ 0.302118] acpiphp: Slot [3] registered [ 0.303081] acpiphp: Slot [4] registered [ 0.305112] acpiphp: Slot [5] registered [ 0.306173] acpiphp: Slot [6] registered [ 0.307096] acpiphp: Slot [7] registered [ 0.308070] acpiphp: Slot [8] registered [ 0.309088] acpiphp: Slot [9] registered [ 0.311068] acpiphp: Slot [10] registered [ 0.312127] acpiphp: Slot [11] registered [ 0.314113] acpiphp: Slot [12] registered [ 0.315091] acpiphp: Slot [13] registered [ 0.317125] acpiphp: Slot [14] registered [ 0.319062] acpiphp: Slot [15] registered [ 0.319872] acpiphp: Slot [16] registered [ 0.321074] acpiphp: Slot [17] registered [ 0.322073] acpiphp: Slot [18] registered [ 0.322933] acpiphp: Slot [19] registered [ 0.324057] acpiphp: Slot [20] registered [ 0.325048] acpiphp: Slot [21] registered [ 0.326076] acpiphp: Slot [22] registered [ 0.327103] acpiphp: Slot [23] registered [ 0.329104] acpiphp: Slot [24] registered [ 0.330137] acpiphp: Slot [25] registered [ 0.331082] acpiphp: Slot [26] registered [ 0.332080] acpiphp: Slot [27] registered [ 0.334125] acpiphp: Slot [28] registered [ 0.335101] acpiphp: Slot [29] registered [ 0.336077] acpiphp: Slot [30] registered [ 0.338134] acpiphp: Slot [31] registered [ 0.339048] PCI host bridge to bus 0000:00 [ 0.339952] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.342014] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.344015] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.346027] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.348014] pci_bus 0000:00: root bus resource [mem 0x180000000-0x1ffffffff window] [ 0.350017] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.351160] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.355504] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.360337] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.367657] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.371050] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.373017] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.374020] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.377024] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.378510] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.380699] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.383044] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.385654] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.389028] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.397018] pci 0000:00:02.0: reg 0x20: [mem 0xfebf4000-0xfebf7fff 64bit pref] [ 0.400016] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.405608] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.418016] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.426019] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.444019] pci 0000:00:05.0: reg 0x20: [mem 0xfebf8000-0xfebfbfff 64bit pref] [ 0.453847] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.459023] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.466030] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.487017] pci 0000:00:06.0: reg 0x20: [mem 0xfebfc000-0xfebfffff 64bit pref] [ 0.498281] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.501323] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.503313] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.504357] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.507198] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.511215] iommu: Default domain type: Passthrough [ 0.513726] SCSI subsystem initialized [ 0.515123] ACPI: bus type USB registered [ 0.516000] usbcore: registered new interface driver usbfs [ 0.516062] usbcore: registered new interface driver hub [ 0.519120] usbcore: registered new device driver usb [ 0.521249] pps_core: LinuxPPS API ver. 1 registered [ 0.522021] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.525071] PTP clock support registered [ 0.527170] EDAC MC: Ver: 3.0.0 [ 0.529143] PCI: Using ACPI for IRQ routing [ 0.530680] NetLabel: Initializing [ 0.532011] NetLabel: domain hash size = 128 [ 0.533005] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.534059] NetLabel: unlabeled traffic allowed by default [ 0.536124] vgaarb: loaded [ 0.537351] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.539013] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.546094] clocksource: Switched to clocksource kvm-clock [ 0.646702] VFS: Disk quotas dquot_6.6.0 [ 0.647766] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.649348] *** VALIDATE ramfs *** [ 0.650030] *** VALIDATE hugetlbfs *** [ 0.650811] pnp: PnP ACPI init [ 0.652850] pnp: PnP ACPI: found 6 devices [ 0.666437] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.668784] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.670478] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.672313] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.674278] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.675623] pci_bus 0000:00: resource 8 [mem 0x180000000-0x1ffffffff window] [ 0.678253] NET: Registered protocol family 2 [ 0.680266] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.683962] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.687032] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.691250] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.694341] TCP: Hash tables configured (established 65536 bind 65536) [ 0.697108] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.699936] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.702351] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.705465] NET: Registered protocol family 1 [ 0.708499] RPC: Registered named UNIX socket transport module. [ 0.710583] RPC: Registered udp transport module. [ 0.712260] RPC: Registered tcp transport module. [ 0.713903] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.716041] NET: Registered protocol family 44 [ 0.717587] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.719584] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.721616] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.723988] PCI: CLS 0 bytes, default 64 [ 0.725504] Unpacking initramfs... [ 2.222129] debug: unmapping init [mem 0xffff8e11fcc64000-0xffff8e11fffcffff] [ 2.226544] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.229285] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.232883] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 2.794681] Initialise system trusted keyrings [ 2.796389] Key type blacklist registered [ 2.798957] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.807684] zbud: loaded [ 2.810702] *** VALIDATE nfs *** [ 2.812069] *** VALIDATE nfs4 *** [ 2.813415] pstore: using deflate compression [ 2.816826] Platform Keyring initialized [ 2.959838] NET: Registered protocol family 38 [ 2.962793] Key type asymmetric registered [ 2.964267] Asymmetric key parser 'x509' registered [ 2.966858] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.972892] io scheduler mq-deadline registered [ 2.974920] io scheduler kyber registered [ 2.976562] io scheduler bfq registered [ 2.978294] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.981539] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.984373] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.988307] ACPI: Power Button [PWRF] [ 3.095480] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.190247] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.313544] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.348853] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.379139] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.383559] Non-volatile memory driver v1.3 [ 3.384984] Linux agpgart interface v0.103 [ 3.411123] virtio_blk virtio1: [vda] 133160 512-byte logical blocks (68.2 MB/65.0 MiB) [ 3.414504] vda: detected capacity change from 0 to 68177920 [ 3.430514] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.433429] vdb: detected capacity change from 0 to 1073741824 [ 3.440384] libphy: Fixed MDIO Bus: probed [ 3.447640] usbcore: registered new interface driver usbserial_generic [ 3.450080] usbserial: USB Serial support registered for generic [ 3.452157] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.460382] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.461838] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.463978] mousedev: PS/2 mouse device common for all mice [ 3.467434] rtc_cmos 00:05: RTC can wake from S4 [ 3.470568] rtc_cmos 00:05: registered as rtc0 [ 3.472060] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.474662] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.478249] intel_pstate: CPU model not supported [ 3.485930] hid: raw HID events driver (C) Jiri Kosina [ 3.494809] usbcore: registered new interface driver usbhid [ 3.496417] usbhid: USB HID core driver [ 3.497688] drop_monitor: Initializing network drop monitor service [ 3.502803] Initializing XFRM netlink socket [ 3.504373] NET: Registered protocol family 10 [ 3.506561] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.509791] Segment Routing with IPv6 [ 3.509834] NET: Registered protocol family 17 [ 3.520535] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.524741] mpls_gso: MPLS GSO support [ 3.529116] RAS: Correctable Errors collector initialized. [ 3.530971] AVX version of gcm_enc/dec engaged. [ 3.532650] AES CTR mode by8 optimization enabled [ 3.653992] sched_clock: Marking stable (3653655623, 0)->(4522724590, -869068967) [ 3.660057] registered taskstats version 1 [ 3.662292] Loading compiled-in X.509 certificates [ 3.664321] zswap: loaded using pool lzo/zbud [ 3.700694] Key type big_key registered [ 3.714559] Key type encrypted registered [ 3.715959] ima: No TPM chip found, activating TPM-bypass! [ 3.717514] ima: Allocated hash algorithm: sha1 [ 3.718790] ima: No architecture policies found [ 3.720075] evm: Initialising EVM extended attributes: [ 3.721572] evm: security.selinux [ 3.722494] evm: security.ima [ 3.723396] evm: security.capability [ 3.724415] evm: HMAC attrs: 0x1 [ 3.726931] rtc_cmos 00:05: setting system clock to 2025-09-24 17:04:28 UTC (1758733468) [ 3.733156] debug: unmapping init [mem 0xffffffff93003000-0xffffffff931fffff] [ 3.736978] debug: unmapping init [mem 0xffffffff91d82000-0xffffffff92058fff] [ 3.756173] Write protecting the kernel read-only data: 28672k [ 3.759372] debug: unmapping init [mem 0xffffffff90403000-0xffffffff905fffff] [ 3.761649] debug: unmapping init [mem 0xffffffff90d14000-0xffffffff90dfffff] [ 3.796857] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.805404] systemd[1]: Detected virtualization kvm. [ 3.807257] systemd[1]: Detected architecture x86-64. [ 3.809264] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.836186] systemd[1]: No hostname configured. [ 3.837802] systemd[1]: Set hostname to . [ 3.839767] random: systemd: uninitialized urandom read (16 bytes read) [ 3.841757] systemd[1]: Initializing machine ID from random generator. [ 4.111576] random: systemd: uninitialized urandom read (16 bytes read) [ 4.114412] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 4.120907] random: systemd: uninitialized urandom read (16 bytes read) [ 4.123489] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 4.129666] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ OK ] Reached target Initrd Root Device. Starting Setup Virtual Console... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on udev Control Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket (/dev/log). Starting Apply Kernel Variables... Starting Journal Service... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Paths. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 5.244893] device-mapper: uevent: version 1.0.3 [ 5.248150] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 6.482369] virtio_net virtio0 ens2: renamed from eth0 [ 6.865638] scsi host0: ata_piix [ 6.930170] scsi host1: ata_piix [ 6.931610] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 6.933578] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.857045] random: fast init done [ 11.235711] random: crng init done [ 11.237267] random: 7 urandom warning(s) missed due to ratelimiting [ 12.081696] dracut-initqueue[580]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 13.622332] 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 Initrd Default Target. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped dracut initqueue hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Kernel Device Manager. [ 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 Cleaning Up and Shutting Down Daemons. [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 15.421622] printk: systemd: 26 output lines suppressed due to ratelimiting [ 15.759604] SELinux: Disabled at runtime. [ 15.848862] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 15.857474] systemd[1]: Detected virtualization kvm. [ 15.859520] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 16.700123] systemd[1]: initrd-switch-root.service: Succeeded. [ 16.705855] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 16.721391] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 16.726043] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 16.730020] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 16.742726] systemd[1]: Starting Journal Service... Starting Journal Service... [ 16.770309] systemd[1]: Mounting Huge Pages File System... Mounting Huge Pages File System... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice User and Session Slice. Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-getty.slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Create list of required st…ce nodes for the current kernel... [ 16.913815] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target Slices. [ OK ] Listening on udev Control Socket. [ OK ] Listening on Process Core Dump Socket. Starting Apply Kernel Variables... [ OK ] Reached target RPC Port Mapper. Mounting POSIX Message Queue File System... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting Kernel Debug File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started 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 /home/green/git/lustre-release... Mounting /mnt... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 17.769371] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 18.505374] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 18.556028] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 18.987497] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 19.195148] EDAC sbridge: Ver: 1.1.2 [ 21.945500] Key type dns_resolver registered [ 22.318132] NFS: Registering the id_resolver key type [ 22.320542] Key type id_resolver registered [ 22.322847] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... Starting Rebuild Dynamic Linker Cache... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Network Manager... [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... [ OK ] Started GSSAPI Proxy Daemon. Starting Hostname Service... [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started OpenSSH server daemon. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ 30.950131] hrtimer: interrupt took 21089963 ns [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg337-client login: [ 88.914197] libcfs: loading out-of-tree module taints kernel. [ 88.964747] Key type ._llcrypt registered [ 88.966202] Key type .llcrypt registered [ 89.472134] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 89.486990] alg: No test for adler32 (adler32-zlib) [ 90.751377] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 91.285393] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 92.959208] Key type lgssc registered [ 94.055231] Lustre: Echo OBD driver; http://www.lustre.org/ [ 187.084093] Lustre: Mounted lustre-client [ 190.070223] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 203.399566] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing check_logdir /tmp/testlogs/ [ 205.774334] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing yml_node [ 208.810824] Lustre: DEBUG MARKER: Client: 2.16.58.51 [ 210.474583] Lustre: DEBUG MARKER: MDS: 2.16.58.51 [ 212.453907] Lustre: DEBUG MARKER: OSS: 2.16.58.51 [ 212.963346] Lustre: lustre-OST0000-osc-ffff8e1245720000: disconnect after 24s idle [ 213.615795] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Sep 24 13:07:57 EDT 2025 [ 225.018348] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 226.104415] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 227.612986] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 237.871646] LustreError: 8991:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 237.892826] Lustre: Unmounted lustre-client [ 324.724827] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 327.093563] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 343.108949] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 378.940709] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 13:10:42 (1758733842) [ 380.653159] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 382.228285] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 13:10:45 (1758733845) [ 404.331471] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 406.854391] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 419.725926] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 420.193809] Lustre: Mounted lustre-client [ 426.502419] LustreError: 14433:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1246f95000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 426.520298] LustreError: 14433:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 426.523714] LustreError: 14433:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 426.579461] Lustre: Unmounted lustre-client [ 445.893932] Key type lgssc unregistered [ 446.098711] LNet: 14840:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 446.114835] LNetError: 14840:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 446.131366] LNet: Removed LNI 192.168.203.37@tcp [ 446.670579] Key type .llcrypt unregistered [ 446.674539] Key type ._llcrypt unregistered [ 456.621668] Key type ._llcrypt registered [ 456.628803] Key type .llcrypt registered [ 457.464903] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 13:12:01 (1758733921) [ 458.345048] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 458.356571] alg: No test for adler32 (adler32-zlib) [ 459.326485] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 459.461103] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 461.087192] Key type lgssc registered [ 461.988525] Lustre: Echo OBD driver; http://www.lustre.org/ [ 517.644379] Lustre: Mounted lustre-client [ 599.795275] LustreError: 18164:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1247b1c800: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 599.802550] LustreError: 18164:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 599.821718] Lustre: Unmounted lustre-client [ 618.243956] Key type lgssc unregistered [ 618.426762] LNet: 18627:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 618.434600] LNetError: 18627:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 618.452268] LNet: Removed LNI 192.168.203.37@tcp [ 618.861526] Key type .llcrypt unregistered [ 618.863318] Key type ._llcrypt unregistered [ 624.663188] Key type ._llcrypt registered [ 624.665438] Key type .llcrypt registered [ 625.667065] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 13:14:49 (1758734089) [ 626.933393] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 626.997678] alg: No test for adler32 (adler32-zlib) [ 627.968743] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 628.117863] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 629.759415] Key type lgssc registered [ 630.435155] Lustre: Echo OBD driver; http://www.lustre.org/ [ 655.877076] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 657.782355] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 668.084721] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 674.824100] Lustre: Mounted lustre-client [ 684.226061] LustreError: 21731:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1246a67800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 684.240899] LustreError: 21731:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 684.273753] Lustre: Unmounted lustre-client [ 700.911989] Key type lgssc unregistered [ 701.112085] LNet: 22133:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 701.122640] LNetError: 22133:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 701.135257] LNet: Removed LNI 192.168.203.37@tcp [ 701.615822] Key type .llcrypt unregistered [ 701.622909] Key type ._llcrypt unregistered [ 708.052643] Key type ._llcrypt registered [ 708.057981] Key type .llcrypt registered [ 708.846469] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 13:16:12 (1758734172) [ 710.270985] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 710.319639] alg: No test for adler32 (adler32-zlib) [ 711.229383] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 711.365297] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 712.992788] Key type lgssc registered [ 713.578585] Lustre: Echo OBD driver; http://www.lustre.org/ [ 741.016449] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 743.391337] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 755.216757] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 757.644863] Lustre: Mounted lustre-client [ 764.799334] LustreError: 24828:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1244022000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 764.812535] LustreError: 24828:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 764.848290] Lustre: Unmounted lustre-client [ 787.395815] Key type lgssc unregistered [ 787.544783] LNet: 25230:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 787.550424] LNetError: 25230:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 787.564151] LNet: Removed LNI 192.168.203.37@tcp [ 787.952685] Key type .llcrypt unregistered [ 787.954239] Key type ._llcrypt unregistered [ 795.716531] Key type ._llcrypt registered [ 795.720307] Key type .llcrypt registered [ 796.643262] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 13:17:40 (1758734260) [ 797.996095] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 798.009291] alg: No test for adler32 (adler32-zlib) [ 799.009947] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 799.165484] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 800.775178] Key type lgssc registered [ 801.537686] Lustre: Echo OBD driver; http://www.lustre.org/ [ 829.734972] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 831.674471] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 841.855144] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 843.242213] Lustre: Mounted lustre-client [ 858.603110] Lustre: lustre-MDT0000-mdc-ffff8e125f369800: Connection to lustre-MDT0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 863.721665] Lustre: lustre-MDT0001-mdc-ffff8e125f369800: Connection to lustre-MDT0001 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 870.454455] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 880.097436] Lustre: 26186:0:(client.c:2464:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1758734328/real 1758734328] req@00000000aff47234 x1844166538566016/t0(0) o400->MGC192.168.203.137@tcp@192.168.203.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1758734344 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 880.114252] LustreError: MGC192.168.203.137@tcp: Connection to MGS (at 192.168.203.137@tcp) was lost; in progress operations using this service will fail [ 880.745153] LustreError: 28400:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 880.766853] Lustre: Unmounted lustre-client [ 893.428923] Key type lgssc unregistered [ 893.573408] LNet: 28789:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 893.579247] LNetError: 28789:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 893.592839] LNet: Removed LNI 192.168.203.37@tcp [ 893.910043] Key type .llcrypt unregistered [ 893.911668] Key type ._llcrypt unregistered [ 901.176780] Key type ._llcrypt registered [ 901.178344] Key type .llcrypt registered [ 901.828096] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 13:19:25 (1758734365) [ 902.839769] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 902.887361] alg: No test for adler32 (adler32-zlib) [ 903.800985] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 903.904202] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 905.519162] Key type lgssc registered [ 906.061038] Lustre: Echo OBD driver; http://www.lustre.org/ [ 928.077926] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 929.683817] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 937.271884] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 947.712345] Lustre: Mounted lustre-client [ 952.804691] Lustre: lustre-OST0000-osc-ffff8e1244024800: Connection to lustre-OST0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 957.363682] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 967.662983] LustreError: 31908:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 967.696747] Lustre: Unmounted lustre-client [ 986.697577] Key type lgssc unregistered [ 986.872633] LNet: 32308:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 986.877230] LNetError: 32308:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 986.892919] LNet: Removed LNI 192.168.203.37@tcp [ 987.246734] Key type .llcrypt unregistered [ 987.247916] Key type ._llcrypt unregistered [ 994.557023] Key type ._llcrypt registered [ 994.558384] Key type .llcrypt registered [ 995.184293] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 13:20:59 (1758734459) [ 996.191109] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 996.198762] alg: No test for adler32 (adler32-zlib) [ 997.109551] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 997.214341] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 998.823175] Key type lgssc registered [ 999.330933] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1020.118667] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1021.610112] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1029.300349] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1039.866749] Lustre: Mounted lustre-client [ 1041.938426] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1043.537265] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1054.195197] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2025-09-2413h21m58s [ 1055.094773] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1060.322753] Lustre: lustre-MDT0000-mdc-ffff8e1244517800: Connection to lustre-MDT0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1062.877786] LustreError: 36002:0:(lmv_obd.c:1434:lmv_statfs()) lustre-MDT0000-mdc-ffff8e1244517800: can't stat MDS #0: rc = -19 [ 1063.480919] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1066.401709] LustreError: MGC192.168.203.137@tcp: Connection to MGS (at 192.168.203.137@tcp) was lost; in progress operations using this service will fail [ 1066.406885] LustreError: lustre-MDT0000-mdc-ffff8e1244517800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1066.415893] Lustre: Evicted from MGS (at 192.168.203.137@tcp) after server handle changed from 0x48625bbb62eff335 to 0x48625bbb62eff6b5 [ 1066.416049] Lustre: lustre-MDT0000-mdc-ffff8e1244517800: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 1066.424214] Lustre: Skipped 1 previous similar message [ 1069.493095] Lustre: DEBUG MARKER: Wait for df (36002) ... [ 1070.145139] Lustre: DEBUG MARKER: done [ 1070.543892] LustreError: 36610:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1244517800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1070.548893] LustreError: 36610:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1070.575085] Lustre: Unmounted lustre-client [ 1089.077472] Key type lgssc unregistered [ 1089.221828] LNet: 37011:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1089.226167] LNetError: 37011:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1089.235867] LNet: Removed LNI 192.168.203.37@tcp [ 1089.539205] Key type .llcrypt unregistered [ 1089.540786] Key type ._llcrypt unregistered [ 1107.733240] Key type ._llcrypt registered [ 1107.737303] Key type .llcrypt registered [ 1107.923354] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1107.930711] alg: No test for adler32 (adler32-zlib) [ 1108.806737] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 1108.906989] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 1110.503248] Key type lgssc registered [ 1110.962640] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1145.125369] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1146.587990] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1155.294504] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1186.216681] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 13:24:10 (1758734650) [ 1198.106413] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1199.578414] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1207.296441] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1218.049947] Lustre: Mounted lustre-client [ 1220.913091] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2025-09-2413h24m44s [ 1221.644321] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1224.815740] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1225.990406] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1246.176653] Lustre: 43857:0:(client.c:2464:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1758734690/real 1758734690] req@00000000563b243d x1844166863623424/t0(0) o101->lustre-MDT0000-mdc-ffff8e125f36b000@192.168.203.137@tcp:12/10 lens 576/1152 e 0 to 1 dl 1758734710 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:0 [ 1246.188564] Lustre: lustre-MDT0000-mdc-ffff8e125f36b000: Connection to lustre-MDT0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1246.205936] Lustre: lustre-MDT0000-mdc-ffff8e125f36b000: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 1266.764835] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1268.099391] Lustre: DEBUG MARKER: done [ 1269.185885] LustreError: 44337:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e125f36b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1269.197798] LustreError: 44337:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1269.222053] Lustre: Unmounted lustre-client [ 1295.911137] Key type lgssc unregistered [ 1296.067827] LNet: 44740:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1296.071962] LNetError: 44740:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1296.085850] LNet: Removed LNI 192.168.203.37@tcp [ 1296.367648] Key type .llcrypt unregistered [ 1296.369421] Key type ._llcrypt unregistered [ 1314.138737] Key type ._llcrypt registered [ 1314.141681] Key type .llcrypt registered [ 1314.325143] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1314.334721] alg: No test for adler32 (adler32-zlib) [ 1315.230652] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 1315.339620] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 1316.935257] Key type lgssc registered [ 1317.446461] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1352.307240] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1354.004688] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1362.808555] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1387.866194] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 13:27:32 (1758734852) [ 1388.434340] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1389.075294] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 13:27:33 (1758734853) [ 1398.311416] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 13:27:42 (1758734862) [ 1410.096698] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1411.503712] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1418.488114] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1428.980620] Lustre: Mounted lustre-client [ 1431.073871] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1432.598242] LustreError: 52556:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1251354800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1432.611128] LustreError: 52556:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1432.640465] Lustre: Unmounted lustre-client [ 1442.984690] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1462.021277] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1463.568456] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1463.814365] Lustre: Mounted lustre-client [ 1464.928250] LustreError: 53812:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12445e8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1464.939969] LustreError: 53812:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1464.942807] LustreError: 53812:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1464.972480] Lustre: Unmounted lustre-client [ 1491.247927] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1492.630441] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1492.836746] Lustre: Mounted lustre-client [ 1493.945115] LustreError: 54929:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1251356000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1493.956361] LustreError: 54929:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1493.958898] LustreError: 54929:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1493.984350] Lustre: Unmounted lustre-client [ 1506.083055] Lustre: DEBUG MARKER: files compared the same [ 1521.289274] Key type lgssc unregistered [ 1521.422562] LNet: 55633:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1521.425627] LNetError: 55633:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1521.438692] LNet: Removed LNI 192.168.203.37@tcp [ 1521.744330] Key type .llcrypt unregistered [ 1521.746188] Key type ._llcrypt unregistered [ 1527.443063] Key type ._llcrypt registered [ 1527.444621] Key type .llcrypt registered [ 1528.017100] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 13:29:52 (1758734992) [ 1528.872500] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1528.893651] alg: No test for adler32 (adler32-zlib) [ 1529.770395] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 1529.872449] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 1531.471191] Key type lgssc registered [ 1531.955335] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1551.051733] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1552.506625] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1559.611658] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1570.299982] Lustre: Mounted lustre-client [ 1572.062321] LustreError: 58714:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1249166800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1572.070319] LustreError: 58714:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1572.098141] Lustre: Unmounted lustre-client [ 1599.008383] Key type lgssc unregistered [ 1599.138769] LNet: 59117:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1599.142685] LNetError: 59117:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1599.152040] LNet: Removed LNI 192.168.203.37@tcp [ 1599.450046] Key type .llcrypt unregistered [ 1599.451807] Key type ._llcrypt unregistered [ 1605.499464] Key type ._llcrypt registered [ 1605.501311] Key type .llcrypt registered [ 1606.097648] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 13:31:10 (1758735070) [ 1607.053979] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1607.070653] alg: No test for adler32 (adler32-zlib) [ 1607.965319] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 1608.068579] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 1609.655158] Key type lgssc registered [ 1610.148936] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1677.678177] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1689.985074] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1691.515058] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1709.976228] Key type lgssc unregistered [ 1710.107504] LNet: 62501:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1710.111452] LNetError: 62501:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1710.120381] LNet: Removed LNI 192.168.203.37@tcp [ 1710.421578] Key type .llcrypt unregistered [ 1710.422947] Key type ._llcrypt unregistered [ 1716.109131] Key type ._llcrypt registered [ 1716.110534] Key type .llcrypt registered [ 1716.645544] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 13:33:00 (1758735180) [ 1718.024836] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1718.033554] alg: No test for adler32 (adler32-zlib) [ 1718.918739] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 1719.015772] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 1720.607415] Key type lgssc registered [ 1721.120977] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1752.779730] Lustre: Mounted lustre-client [ 1758.522775] LustreError: 64982:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1243c75000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1758.531893] LustreError: 64982:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1758.557157] Lustre: Unmounted lustre-client [ 1779.656743] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 13:34:03 (1758735243) [ 1823.953740] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1835.518556] Lustre: Mounted lustre-client [ 1840.916564] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1840.919957] LustreError: 68933:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff8e12445f7800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 1840.929059] Lustre: 63480:0:(llite_lib.c:4239:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.137@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 1851.175030] LustreError: 68933:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 1851.178312] LustreError: 68933:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1851.193302] Lustre: Unmounted lustre-client [ 1896.715932] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 13:36:00 (1758735360) [ 1901.467377] Key type lgssc unregistered [ 1901.599497] LNet: 70143:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1901.603060] LNetError: 70143:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1901.613123] LNet: Removed LNI 192.168.203.37@tcp [ 1901.881508] Key type .llcrypt unregistered [ 1901.882914] Key type ._llcrypt unregistered [ 1906.638455] Key type ._llcrypt registered [ 1906.639778] Key type .llcrypt registered [ 1906.839954] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1906.847195] alg: No test for adler32 (adler32-zlib) [ 1907.715066] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 1907.807635] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 1909.391169] Key type lgssc registered [ 1909.818714] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1932.746349] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1934.361234] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1942.341990] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1948.656062] Lustre: Mounted lustre-client [ 1954.098515] LustreError: 72659:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1249160800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1954.107989] LustreError: 72659:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 1954.133161] Lustre: Unmounted lustre-client [ 1975.273173] Key type lgssc unregistered [ 1975.410673] LNet: 73061:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1975.413813] LNetError: 73061:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1975.422169] LNet: Removed LNI 192.168.203.37@tcp [ 1975.686714] Key type .llcrypt unregistered [ 1975.688071] Key type ._llcrypt unregistered [ 1979.898790] Key type ._llcrypt registered [ 1979.900485] Key type .llcrypt registered [ 1980.088981] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1980.094896] alg: No test for adler32 (adler32-zlib) [ 1980.993219] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 1981.111028] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 1982.703175] Key type lgssc registered [ 1983.142448] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2037.842180] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2039.379083] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2047.193959] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2057.715697] Lustre: Mounted lustre-client [ 2058.212729] LustreError: 75992:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1249163800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2058.223542] LustreError: 75992:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2058.255796] Lustre: Unmounted lustre-client [ 2076.386079] Key type lgssc unregistered [ 2076.509617] LNet: 76393:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2076.512225] LNetError: 76393:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2076.519644] LNet: Removed LNI 192.168.203.37@tcp [ 2076.774470] Key type .llcrypt unregistered [ 2076.775616] Key type ._llcrypt unregistered [ 2082.469056] Key type ._llcrypt registered [ 2082.470618] Key type .llcrypt registered [ 2082.966867] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 13:39:07 (1758735547) [ 2083.854487] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2083.864706] alg: No test for adler32 (adler32-zlib) [ 2084.733194] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 2084.821468] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 2086.407246] Key type lgssc registered [ 2086.846194] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2106.808841] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2108.284643] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2115.004218] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2125.810191] Lustre: Mounted lustre-client [ 2128.157827] LustreError: 79506:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1249165000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2128.165788] LustreError: 79506:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2128.190166] Lustre: Unmounted lustre-client [ 2128.328299] Lustre: Mounted lustre-client [ 2129.032762] LustreError: 79584:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12440a4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2129.039859] LustreError: 79584:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2129.042820] LustreError: 79584:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2129.071150] Lustre: Unmounted lustre-client [ 2154.905475] Key type lgssc unregistered [ 2155.019619] LNet: 79987:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2155.021778] LNetError: 79987:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2155.030634] LNet: Removed LNI 192.168.203.37@tcp [ 2155.260375] Key type .llcrypt unregistered [ 2155.261510] Key type ._llcrypt unregistered [ 2159.210385] Key type ._llcrypt registered [ 2159.211331] Key type .llcrypt registered [ 2159.451201] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2159.457199] alg: No test for adler32 (adler32-zlib) [ 2160.317986] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 2160.394167] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 2161.975120] Key type lgssc registered [ 2162.390705] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2180.497569] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2181.889094] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2188.800984] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2199.543186] Lustre: Mounted lustre-client [ 2201.365326] LustreError: 82521:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1247e84000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2201.373280] LustreError: 82521:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2201.396090] Lustre: Unmounted lustre-client [ 2220.155854] Key type lgssc unregistered [ 2220.288588] LNet: 82923:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2220.293574] LNetError: 82923:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2220.306350] LNet: Removed LNI 192.168.203.37@tcp [ 2220.583281] Key type .llcrypt unregistered [ 2220.584745] Key type ._llcrypt unregistered [ 2226.706549] Key type ._llcrypt registered [ 2226.708127] Key type .llcrypt registered [ 2227.260596] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 13:41:31 (1758735691) [ 2228.127865] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2228.156105] alg: No test for adler32 (adler32-zlib) [ 2229.031228] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 2229.130870] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 2230.727253] Key type lgssc registered [ 2231.188934] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2252.123772] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2253.570960] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2261.545615] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2272.237666] Lustre: Mounted lustre-client [ 2275.222724] Lustre: lustre: root_squash is set to 0:0 [ 2283.003193] Lustre: lustre: nosquash_nids is cleared [ 2283.014410] Lustre: lustre: root_squash is set to 500:500 [ 2290.680622] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.37@tcp 192.168.0.[2,10]@tcp [ 2295.986242] Lustre: lustre: nosquash_nids set to 192.168.203.37/24@tcp [ 2298.791387] LustreError: 86394:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1258500800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2298.800485] LustreError: 86394:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2298.823337] Lustre: Unmounted lustre-client [ 2324.549878] Key type lgssc unregistered [ 2324.681619] LNet: 86797:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2324.685378] LNetError: 86797:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2324.697830] LNet: Removed LNI 192.168.203.37@tcp [ 2324.962797] Key type .llcrypt unregistered [ 2324.964301] Key type ._llcrypt unregistered [ 2330.514137] Key type ._llcrypt registered [ 2330.515220] Key type .llcrypt registered [ 2331.046850] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 13:43:15 (1758735795) [ 2331.999543] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 2332.641567] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 13:43:16 (1758735796) [ 2333.381593] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2333.423050] alg: No test for adler32 (adler32-zlib) [ 2334.291915] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 2334.388429] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 2335.983178] Key type lgssc registered [ 2336.404943] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2356.459867] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2357.873090] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2365.040134] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2365.217962] Lustre: lustre: root_squash is set to 500:500 [ 2365.227906] Lustre: lustre: nosquash_nids set to 192.168.203.37/24@tcp [ 2375.670052] Lustre: Mounted lustre-client [ 2378.205347] LustreError: 90254:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1243c76800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2378.213968] LustreError: 90254:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2378.236839] Lustre: Unmounted lustre-client [ 2404.535577] Key type lgssc unregistered [ 2404.658576] LNet: 90658:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2404.661775] LNetError: 90658:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2404.674035] LNet: Removed LNI 192.168.203.37@tcp [ 2404.944908] Key type .llcrypt unregistered [ 2404.946418] Key type ._llcrypt unregistered [ 2410.786732] Key type ._llcrypt registered [ 2410.787962] Key type .llcrypt registered [ 2411.297774] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 2411.958131] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 13:44:36 (1758735876) [ 2419.215971] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2419.223850] alg: No test for adler32 (adler32-zlib) [ 2420.093154] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 2420.183169] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 2421.783159] Key type lgssc registered [ 2422.252378] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2453.687299] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2455.043404] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2463.306842] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2501.514973] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2502.736180] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2508.942562] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2523.221618] Lustre: Mounted lustre-client [ 2537.665400] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8e124574c800.ost_server_uuid 50 [ 2538.189719] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8e124574c800.ost_server_uuid in FULL state after 0 sec [ 2538.336815] Lustre: Mounted lustre-client [ 2539.087840] LustreError: 97535:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12445f0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2539.095451] LustreError: 97535:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 2539.123642] Lustre: Unmounted lustre-client [ 2575.196587] Key type lgssc unregistered [ 2575.318511] LNet: 98107:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2575.321939] LNetError: 98107:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2575.329637] LNet: Removed LNI 192.168.203.37@tcp [ 2575.582961] Key type .llcrypt unregistered [ 2575.584539] Key type ._llcrypt unregistered [ 2590.062643] Key type ._llcrypt registered [ 2590.064259] Key type .llcrypt registered [ 2590.261223] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2590.267980] alg: No test for adler32 (adler32-zlib) [ 2591.111781] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 2591.186778] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 2592.767140] Key type lgssc registered [ 2593.140032] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2621.983458] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2623.267429] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2630.892754] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2652.897927] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 13:48:37 (1758736117) [ 2682.985260] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2684.118731] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2691.397262] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2697.689071] Lustre: Mounted lustre-client [ 2713.059951] Lustre: lustre-OST0000-osc-ffff8e1248619000: Connection to lustre-OST0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2718.177742] Lustre: lustre-MDT0000-mdc-ffff8e1248619000: Connection to lustre-MDT0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2719.199230] Lustre: 98888:0:(client.c:2464:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1758736167/real 1758736167] req@00000000269f723f x1844168417613568/t0(0) o400->lustre-OST0000-osc-ffff8e1248619000@192.168.203.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1758736183 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2723.295151] Lustre: 98888:0:(client.c:2464:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1758736172/real 1758736172] req@00000000cd9a840a x1844168417614080/t0(0) o400->lustre-OST0000-osc-ffff8e1248619000@192.168.203.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1758736188 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2727.813295] Lustre: lustre-OST0000-osc-ffff8e1248619000: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 2728.417230] LustreError: MGC192.168.203.137@tcp: Connection to MGS (at 192.168.203.137@tcp) was lost; in progress operations using this service will fail [ 2728.422987] Lustre: 106005:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.203.137@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 2728.425415] Lustre: Evicted from MGS (at 192.168.203.137@tcp) after server handle changed from 0x536a63c765eef337 to 0x536a63c765eef671 [ 2728.431183] Lustre: MGC192.168.203.137@tcp: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 2732.840786] Lustre: lustre-MDT0000-mdc-ffff8e1248619000: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 2733.198780] LustreError: 106724:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1248619000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2733.204744] LustreError: 106724:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2733.222676] Lustre: Unmounted lustre-client [ 2750.486854] Key type lgssc unregistered [ 2750.608554] LNet: 107124:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2750.611830] LNetError: 107124:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2750.619739] LNet: Removed LNI 192.168.203.37@tcp [ 2750.890484] Key type .llcrypt unregistered [ 2750.892392] Key type ._llcrypt unregistered [ 2755.915071] Key type ._llcrypt registered [ 2755.916354] Key type .llcrypt registered [ 2756.390172] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 13:50:20 (1758736220) [ 2768.047953] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2768.110523] alg: No test for adler32 (adler32-zlib) [ 2768.970446] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 2769.049938] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 2770.631200] Key type lgssc registered [ 2771.019593] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2785.231401] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2819.507658] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2820.812886] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2828.204688] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2829.363396] Lustre: Mounted lustre-client [ 2830.049956] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 2830.621606] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 13:51:34 (1758736294) [ 2889.515635] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2899.814126] LustreError: 117853:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2899.826107] Lustre: Unmounted lustre-client [ 2965.677882] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2966.809838] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2974.143473] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3003.839830] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 13:54:28 (1758736468) [ 3034.726734] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3035.873435] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3043.124548] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3043.257764] Lustre: Mounted lustre-client [ 3044.175535] LustreError: 125248:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1246a64000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3044.181475] LustreError: 125248:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3044.182983] LustreError: 125248:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3044.200834] Lustre: Unmounted lustre-client [ 3069.541329] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 13:55:33 (1758736533) [ 3116.119133] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3117.389905] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3126.254000] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3126.683842] Lustre: Mounted lustre-client [ 3130.024634] LustreError: 129289:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1249167800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3130.062484] LustreError: 129289:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3130.065459] LustreError: 129289:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3130.128948] Lustre: Unmounted lustre-client [ 3157.793522] Key type lgssc unregistered [ 3158.062097] LNet: 129692:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3158.084479] LNetError: 129692:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3159.145688] LNet: Removed LNI 192.168.203.37@tcp [ 3159.946213] Key type .llcrypt unregistered [ 3159.953466] Key type ._llcrypt unregistered [ 3175.216362] Key type ._llcrypt registered [ 3175.218016] Key type .llcrypt registered [ 3176.289409] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 13:57:19 (1758736639) [ 3177.592473] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3177.638119] alg: No test for adler32 (adler32-zlib) [ 3178.574988] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 3178.768424] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 3180.399173] Key type lgssc registered [ 3181.042644] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3209.269153] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3211.354111] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3223.532723] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3225.024427] Lustre: Mounted lustre-client [ 3240.380472] LustreError: 132796:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1244db6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3240.399741] LustreError: 132796:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3240.462376] Lustre: Unmounted lustre-client [ 3263.206786] Key type lgssc unregistered [ 3263.416231] LNet: 133199:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3263.426941] LNetError: 133199:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3263.442339] LNet: Removed LNI 192.168.203.37@tcp [ 3263.832332] Key type .llcrypt unregistered [ 3263.835088] Key type ._llcrypt unregistered [ 3272.272498] Key type ._llcrypt registered [ 3272.273818] Key type .llcrypt registered [ 3273.061150] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 13:58:56 (1758736736) [ 3274.362824] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3274.444553] alg: No test for adler32 (adler32-zlib) [ 3275.379667] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 3275.503720] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 3277.127166] Key type lgssc registered [ 3277.683136] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3298.503111] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3300.172320] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3307.761944] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3319.296155] Lustre: Mounted lustre-client [ 3324.390381] Lustre: lustre-OST0000-osc-ffff8e1243c76800: Connection to lustre-OST0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3330.493438] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8e1243c76800.ost_server_uuid 50 [ 3331.193397] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 3340.534872] LustreError: 136729:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1243c76800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3340.539715] LustreError: 136729:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3340.559810] Lustre: Unmounted lustre-client [ 3352.280559] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 14:00:16 (1758736816) [ 3363.362394] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3364.936421] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3373.006809] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3382.411833] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3382.669968] Lustre: Mounted lustre-client [ 3387.876782] Lustre: lustre-OST0000-osc-ffff8e1249164800: Connection to lustre-OST0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3403.174867] LustreError: 139389:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1249164800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3403.185037] LustreError: 139389:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3403.187031] LustreError: 139389:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3403.221325] Lustre: Unmounted lustre-client [ 3437.148234] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 14:01:41 (1758736901) [ 3448.404540] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3449.791355] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3456.403776] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3463.113995] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3463.322262] Lustre: Mounted lustre-client [ 3468.772289] Lustre: lustre-OST0000-osc-ffff8e1247d38000: Connection to lustre-OST0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3480.167996] LustreError: 142138:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1247d38000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3480.172323] LustreError: 142138:0:(lov_obd.c:784:lov_cleanup()) Skipped 1 previous similar message [ 3480.178078] LustreError: 142138:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3480.180231] LustreError: 142138:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3480.200194] Lustre: Unmounted lustre-client [ 3504.409877] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 14:02:48 (1758736968) [ 3556.411358] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3560.084613] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3578.069994] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3624.350132] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3626.251082] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3636.891313] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3657.311813] Lustre: Mounted lustre-client [ 3689.608492] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3704.108443] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 13 sec [ 3705.579603] LustreError: 148825:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1258c6f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3705.589247] LustreError: 148825:0:(lov_obd.c:784:lov_cleanup()) Skipped 1 previous similar message [ 3705.603209] LustreError: 148825:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3705.606802] LustreError: 148825:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3705.642638] Lustre: Unmounted lustre-client [ 3739.592947] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 14:06:43 (1758737203) [ 3759.725818] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3762.010642] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3772.985368] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3790.694291] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3815.808484] Lustre: Mounted lustre-client [ 3856.276905] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 3858.499611] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 3861.997833] Lustre: lustre-OST0001-osc-ffff8e12442cb000: Connection to lustre-OST0001 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3870.099538] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3880.379121] LustreError: 152404:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3880.381775] LustreError: 152404:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3880.505399] Lustre: Unmounted lustre-client [ 3946.841795] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 14:10:10 (1758737410) [ 3969.181303] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3972.025244] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3987.247841] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3987.796057] Lustre: Mounted lustre-client [ 4003.289154] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4004.281930] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 4012.916373] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8e1258c6c000.ost_server_uuid 50 [ 4014.104540] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8e1258c6c000.ost_server_uuid in FULL state after 0 sec [ 4016.451118] LustreError: 155830:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1258c6c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4016.466373] LustreError: 155830:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4016.470082] LustreError: 155830:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 4016.532211] Lustre: Unmounted lustre-client [ 4016.816573] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 4016.828970] Lustre: Skipped 3 previous similar messages [ 4016.953908] Lustre: Mounted lustre-client [ 4017.791869] LustreError: 155895:0:(sec.c:411:import_sec_validate_get()) import 00000000e60fcbc1 (NEW) with no sec [ 4064.619844] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 14:12:08 (1758737528) [ 4090.554440] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4093.652919] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4110.341713] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4122.982646] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4123.379993] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 4128.792855] Lustre: Mounted lustre-client [ 4133.933369] LustreError: 158715:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e125f36f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4133.939888] LustreError: 158715:0:(lov_obd.c:784:lov_cleanup()) Skipped 2 previous similar messages [ 4133.956410] LustreError: 158715:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4133.961335] LustreError: 158715:0:(obd_class.h:479:obd_check_dev()) Skipped 18 previous similar messages [ 4134.032030] Lustre: Unmounted lustre-client [ 4134.034611] Lustre: Skipped 1 previous similar message [ 4164.845466] Key type lgssc unregistered [ 4165.022046] LNet: 159162:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4165.031626] LNetError: 159162:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4165.041568] LNet: Removed LNI 192.168.203.37@tcp [ 4165.516394] Key type .llcrypt unregistered [ 4165.518073] Key type ._llcrypt unregistered [ 4174.070194] Key type ._llcrypt registered [ 4174.074578] Key type .llcrypt registered [ 4175.054153] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 14:13:58 (1758737638) [ 4175.654550] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4175.720588] alg: No test for adler32 (adler32-zlib) [ 4176.692370] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 4176.820992] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 4178.455494] Key type lgssc registered [ 4179.285947] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4212.549210] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4215.165572] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4231.402601] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4247.071240] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4248.434380] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 4249.564284] Lustre: Mounted lustre-client [ 4256.249913] LustreError: lustre-MDT0001-mdc-ffff8e124873f000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 4256.259489] Lustre: lustre-MDT0001-mdc-ffff8e124873f000: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 4259.098824] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4260.400907] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 4278.773128] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 4281.878172] LustreError: 163412:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e124873f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4281.888112] LustreError: 163412:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4281.938021] Lustre: Unmounted lustre-client [ 4307.362323] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 14:16:11 (1758737771) [ 4357.727520] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4359.897991] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4372.224065] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4378.131932] Lustre: Mounted lustre-client [ 4394.369065] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4395.461764] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 4401.134308] Lustre: lustre-OST0001-osc-ffff8e1249160800: Connection to lustre-OST0001 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4409.198677] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4419.509406] LustreError: 168134:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4419.534697] LustreError: 168134:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 4419.607453] Lustre: Unmounted lustre-client [ 4458.118197] Key type lgssc unregistered [ 4458.306410] LNet: 168541:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4458.311346] LNetError: 168541:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4458.323678] LNet: Removed LNI 192.168.203.37@tcp [ 4458.694403] Key type .llcrypt unregistered [ 4458.696101] Key type ._llcrypt unregistered [ 4484.517328] Key type ._llcrypt registered [ 4484.519079] Key type .llcrypt registered [ 4484.748459] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4484.758871] alg: No test for adler32 (adler32-zlib) [ 4485.678840] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 4485.795789] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 4487.407097] Key type lgssc registered [ 4488.007719] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4536.603710] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4539.110117] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4553.147670] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4591.794831] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 14:20:55 (1758738055) [ 4608.787352] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4610.672773] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4621.935423] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4623.406467] Lustre: Mounted lustre-client [ 4666.295922] LustreError: 174613:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1243bc2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4666.311860] LustreError: 174613:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4666.355906] Lustre: Unmounted lustre-client [ 4691.837817] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4692.252035] Lustre: Mounted lustre-client [ 4726.671967] LustreError: 175270:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e124898f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4726.687816] LustreError: 175270:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4726.690330] LustreError: 175270:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 4726.729525] Lustre: Unmounted lustre-client [ 4748.020799] Key type lgssc unregistered [ 4748.171952] LNet: 175677:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4748.177356] LNetError: 175677:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4749.223698] LNet: Removed LNI 192.168.203.37@tcp [ 4749.575778] Key type .llcrypt unregistered [ 4749.578081] Key type ._llcrypt unregistered [ 4756.481613] Key type ._llcrypt registered [ 4756.483194] Key type .llcrypt registered [ 4757.037927] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 14:23:41 (1758738221) [ 4758.092636] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4758.101470] alg: No test for adler32 (adler32-zlib) [ 4759.001749] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 4759.102754] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 4760.703160] Key type lgssc registered [ 4761.180197] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4786.709415] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4788.953700] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4800.751597] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4802.142826] Lustre: Mounted lustre-client [ 4817.313472] LustreError: 178932:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1258c6d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4817.326654] LustreError: 178932:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4817.356906] Lustre: Unmounted lustre-client [ 4838.282951] Key type lgssc unregistered [ 4838.444363] LNet: 179334:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4838.451684] LNetError: 179334:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4839.526697] LNet: Removed LNI 192.168.203.37@tcp [ 4839.916270] Key type .llcrypt unregistered [ 4839.917976] Key type ._llcrypt unregistered [ 4846.760134] Key type ._llcrypt registered [ 4846.761813] Key type .llcrypt registered [ 4846.945705] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4846.953930] alg: No test for adler32 (adler32-zlib) [ 4847.867598] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 4848.001960] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 4849.639262] Key type lgssc registered [ 4850.160510] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4881.125568] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4883.196138] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4895.443693] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4896.587840] Lustre: Mounted lustre-client [ 4904.690494] LustreError: 181900:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1251353800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4904.706472] LustreError: 181900:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4904.749348] Lustre: Unmounted lustre-client [ 4924.727149] Key type lgssc unregistered [ 4924.885313] LNet: 182300:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4924.890541] LNetError: 182300:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4924.913721] LNet: Removed LNI 192.168.203.37@tcp [ 4925.280196] Key type .llcrypt unregistered [ 4925.282128] Key type ._llcrypt unregistered [ 4932.869498] Key type ._llcrypt registered [ 4932.872627] Key type .llcrypt registered [ 4933.658234] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 14:26:37 (1758738397) [ 4935.098505] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4935.118067] alg: No test for adler32 (adler32-zlib) [ 4936.063513] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 4936.189098] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 4937.799232] Key type lgssc registered [ 4938.386027] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4964.505685] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4966.517162] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4977.111408] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4983.796479] Lustre: Mounted lustre-client [ 4995.621537] LustreError: 185553:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12512e8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4995.636526] LustreError: 185553:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4995.676363] Lustre: Unmounted lustre-client [ 5016.025176] Key type lgssc unregistered [ 5016.248918] LNet: 185954:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5016.262799] LNetError: 185954:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5017.322063] LNet: Removed LNI 192.168.203.37@tcp [ 5017.845858] Key type .llcrypt unregistered [ 5017.847880] Key type ._llcrypt unregistered [ 5025.514219] Key type ._llcrypt registered [ 5025.515887] Key type .llcrypt registered [ 5025.780071] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5025.788732] alg: No test for adler32 (adler32-zlib) [ 5026.729706] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 5026.872582] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 5028.503149] Key type lgssc registered [ 5029.251508] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5061.476840] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5063.568332] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5077.502285] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5079.057604] Lustre: Mounted lustre-client [ 5087.660937] LustreError: 188520:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12482da000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5087.691330] LustreError: 188520:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5087.732504] Lustre: Unmounted lustre-client [ 5109.338607] Key type lgssc unregistered [ 5109.499797] LNet: 188921:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5109.503592] LNetError: 188921:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5109.517826] LNet: Removed LNI 192.168.203.37@tcp [ 5110.018484] Key type .llcrypt unregistered [ 5110.021237] Key type ._llcrypt unregistered [ 5119.317983] Key type ._llcrypt registered [ 5119.320357] Key type .llcrypt registered [ 5120.214800] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 14:29:43 (1758738583) [ 5133.855543] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5133.877210] alg: No test for adler32 (adler32-zlib) [ 5134.869740] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 5135.009664] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 5136.661184] Key type lgssc registered [ 5137.502182] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5195.620531] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5198.378937] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5211.921587] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5243.000332] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 14:31:46 (1758738706) [ 5263.139239] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5266.083788] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5280.046588] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5281.477902] Lustre: Mounted lustre-client [ 5289.915855] LustreError: 195431:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1243c76800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5289.941733] LustreError: 195431:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5290.012339] Lustre: Unmounted lustre-client [ 5314.654246] Key type lgssc unregistered [ 5314.911218] LNet: 195831:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5314.917397] LNetError: 195831:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5314.944545] LNet: Removed LNI 192.168.203.37@tcp [ 5315.535183] Key type .llcrypt unregistered [ 5315.537197] Key type ._llcrypt unregistered [ 5327.467467] Key type ._llcrypt registered [ 5327.470061] Key type .llcrypt registered [ 5328.487326] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 5330.085569] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 14:33:13 (1758738793) [ 5343.274551] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5343.307338] alg: No test for adler32 (adler32-zlib) [ 5344.330942] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 5344.501979] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 5346.151230] Key type lgssc registered [ 5347.044377] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5418.414811] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5421.102778] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5439.696182] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 5452.356499] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 5454.772419] Lustre: Mounted lustre-client [ 5469.207501] LustreError: 201374:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1245b32800: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 5469.248594] LustreError: 201374:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5469.323163] Lustre: Unmounted lustre-client [ 5577.665176] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5580.748679] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5601.378674] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5634.797668] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 14:38:18 (1758739098) [ 5635.875660] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 5637.314626] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 14:38:21 (1758739101) [ 5678.435703] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5681.150891] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5707.082634] Key type lgssc unregistered [ 5707.364942] LNet: 207559:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5707.376429] LNetError: 207559:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5707.395392] LNet: Removed LNI 192.168.203.37@tcp [ 5707.979802] Key type .llcrypt unregistered [ 5707.985817] Key type ._llcrypt unregistered [ 5721.006383] Key type ._llcrypt registered [ 5721.010398] Key type .llcrypt registered [ 5722.167397] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 14:39:45 (1758739185) [ 5752.181777] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5752.217112] alg: No test for adler32 (adler32-zlib) [ 5753.284279] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 5753.498862] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 5755.160232] Key type lgssc registered [ 5756.420474] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5792.800932] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5795.657874] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5810.847392] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5836.127885] Key type lgssc unregistered [ 5836.338051] LNet: 211190:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5836.349530] LNetError: 211190:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5836.368150] LNet: Removed LNI 192.168.203.37@tcp [ 5836.967330] Key type .llcrypt unregistered [ 5836.972534] Key type ._llcrypt unregistered [ 5850.356641] Key type ._llcrypt registered [ 5850.361670] Key type .llcrypt registered [ 5851.475603] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 14:41:54 (1758739314) [ 5853.574611] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5853.600254] alg: No test for adler32 (adler32-zlib) [ 5854.659140] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 5854.835070] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 5856.479174] Key type lgssc registered [ 5857.386372] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5898.209678] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5901.265373] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5920.553551] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5926.470593] Lustre: Mounted lustre-client [ 5936.620247] Lustre: lustre-MDT0000-mdc-ffff8e1251355000: Connection to lustre-MDT0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5946.871041] Lustre: lustre-MDT0001-mdc-ffff8e1251355000: Connection to lustre-MDT0001 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5958.112263] Lustre: 212173:0:(client.c:2464:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1758739406/real 1758739406] req@00000000bcdc524f x1844171840241920/t0(0) o400->MGC192.168.203.137@tcp@192.168.203.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1758739422 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5958.157095] LustreError: MGC192.168.203.137@tcp: Connection to MGS (at 192.168.203.137@tcp) was lost; in progress operations using this service will fail [ 5967.398988] Lustre: Evicted from MGS (at 192.168.203.137@tcp) after server handle changed from 0xfc6c6fe3faf85edb to 0xfc6c6fe3faf87be5 [ 5967.408637] Lustre: MGC192.168.203.137@tcp: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 5985.724963] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5986.805808] LustreError: lustre-MDT0000-mdc-ffff8e1251355000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 5986.857447] Lustre: lustre-MDT0000-mdc-ffff8e1251355000: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 5988.264267] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 1 sec [ 5991.064635] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5992.852743] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5994.564137] LustreError: 215607:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1251355000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5994.578347] LustreError: 215607:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5994.651790] Lustre: Unmounted lustre-client [ 6019.875447] Key type lgssc unregistered [ 6020.165444] LNet: 216009:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6020.186264] LNetError: 216009:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6020.211567] LNet: Removed LNI 192.168.203.37@tcp [ 6020.787472] Key type .llcrypt unregistered [ 6020.789199] Key type ._llcrypt unregistered [ 6036.865313] Key type ._llcrypt registered [ 6036.867939] Key type .llcrypt registered [ 6038.075481] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 14:45:01 (1758739501) [ 6040.379569] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6040.407628] alg: No test for adler32 (adler32-zlib) [ 6041.486663] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 6041.681499] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 6043.351144] Key type lgssc registered [ 6044.386018] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6087.667337] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6090.302127] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6138.989479] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6141.380792] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6161.369951] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6174.360306] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6216.192469] Key type lgssc unregistered [ 6216.424579] LNet: 221120:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6216.433750] LNetError: 221120:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6216.455208] LNet: Removed LNI 192.168.203.37@tcp [ 6216.989641] Key type .llcrypt unregistered [ 6216.993777] Key type ._llcrypt unregistered [ 6253.063378] Key type ._llcrypt registered [ 6253.065375] Key type .llcrypt registered [ 6253.390124] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6253.406619] alg: No test for adler32 (adler32-zlib) [ 6254.399302] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 6254.599353] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 6256.232054] Key type lgssc registered [ 6257.178788] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6314.727962] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6317.349433] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6331.883313] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6370.711322] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 14:50:34 (1758739834) [ 6443.494376] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6445.915314] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6459.250114] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6488.323435] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 14:52:32 (1758739952) [ 6492.459153] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 14:52:36 (1758739956) [ 6509.899413] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6512.013271] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6523.206681] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6524.507143] Lustre: Mounted lustre-client [ 6531.918295] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 6532.954697] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 6533.858842] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 6534.711201] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 6539.751722] Lustre: lustre-MDT0000-mdc-ffff8e12482d8000: Connection to lustre-MDT0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6555.117769] LustreError: MGC192.168.203.137@tcp: Connection to MGS (at 192.168.203.137@tcp) was lost; in progress operations using this service will fail [ 6555.138741] Lustre: Evicted from MGS (at 192.168.203.137@tcp) after server handle changed from 0x4265c1ad2f47d75d to 0x4265c1ad2f47d9e1 [ 6555.148832] Lustre: MGC192.168.203.137@tcp: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 6556.488586] Lustre: lustre-MDT0000-mdc-ffff8e12482d8000: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 6559.160350] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6560.284677] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6563.168907] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 6565.349864] Lustre: lustre-MDT0000-mdc-ffff8e12482d8000: Connection to lustre-MDT0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6580.710480] LustreError: MGC192.168.203.137@tcp: Connection to MGS (at 192.168.203.137@tcp) was lost; in progress operations using this service will fail [ 6580.722885] Lustre: Evicted from MGS (at 192.168.203.137@tcp) after server handle changed from 0x4265c1ad2f47d9e1 to 0x4265c1ad2f47dce3 [ 6580.729341] Lustre: MGC192.168.203.137@tcp: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 6584.626647] Lustre: lustre-MDT0000-mdc-ffff8e12482d8000: Connection restored to 192.168.203.137@tcp (at 192.168.203.137@tcp) [ 6586.502975] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6587.351599] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6589.267570] LustreError: 234728:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12482d8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6589.278883] LustreError: 234728:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6589.311743] Lustre: Unmounted lustre-client [ 6631.192892] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6633.211524] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6642.576979] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6648.372207] Lustre: Mounted lustre-client [ 6654.170081] LustreError: 236348:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12469ad000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6654.183541] LustreError: 236348:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6654.186454] LustreError: 236348:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 6654.220896] Lustre: Unmounted lustre-client [ 6664.988950] Key type lgssc unregistered [ 6665.163601] LNet: 236750:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6665.167888] LNetError: 236750:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6665.179387] LNet: Removed LNI 192.168.203.37@tcp [ 6665.585260] Key type .llcrypt unregistered [ 6665.587076] Key type ._llcrypt unregistered [ 6674.754597] Key type ._llcrypt registered [ 6674.756244] Key type .llcrypt registered [ 6675.499506] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 14:55:39 (1758740139) [ 6677.725274] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6677.738077] alg: No test for adler32 (adler32-zlib) [ 6678.680578] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 6678.820853] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 6680.449414] Key type lgssc registered [ 6681.253223] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6709.642159] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6711.937850] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6722.247860] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6723.545049] Lustre: Mounted lustre-client [ 6736.255832] LustreError: 239919:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e124574c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6736.268309] LustreError: 239919:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6736.319190] Lustre: Unmounted lustre-client [ 6773.544770] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6775.022542] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6782.721517] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6793.213771] Lustre: Mounted lustre-client [ 6799.711175] LustreError: 241514:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12469a9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6799.725179] LustreError: 241514:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6799.728115] LustreError: 241514:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 6799.759160] Lustre: Unmounted lustre-client [ 6839.399150] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6841.185704] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6850.404647] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6855.678591] Lustre: Mounted lustre-client [ 6856.102139] LustreError: 243128:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e124409b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6856.112578] LustreError: 243128:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6856.115885] LustreError: 243128:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 6856.149192] Lustre: Unmounted lustre-client [ 6875.247318] Key type lgssc unregistered [ 6875.392638] LNet: 243530:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6875.397181] LNetError: 243530:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6875.411318] LNet: Removed LNI 192.168.203.37@tcp [ 6875.796115] Key type .llcrypt unregistered [ 6875.797923] Key type ._llcrypt unregistered [ 6883.127153] Key type ._llcrypt registered [ 6883.128545] Key type .llcrypt registered [ 6883.814935] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 14:59:07 (1758740347) [ 6885.395186] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6885.408991] alg: No test for adler32 (adler32-zlib) [ 6886.298557] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 6886.399366] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 6887.991220] Key type lgssc registered [ 6888.505474] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6908.695589] Key type lgssc unregistered [ 6908.829761] LNet: 245843:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6908.833360] LNetError: 245843:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6908.845526] LNet: Removed LNI 192.168.203.37@tcp [ 6909.175524] Key type .llcrypt unregistered [ 6909.177377] Key type ._llcrypt unregistered [ 6921.744282] Key type ._llcrypt registered [ 6921.745906] Key type .llcrypt registered [ 6921.976383] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6921.983147] alg: No test for adler32 (adler32-zlib) [ 6922.881203] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 6922.990242] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 6924.591173] Key type lgssc registered [ 6925.283682] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6966.490490] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6968.452480] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6980.072640] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7005.931532] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 7006.792828] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 15:01:10 (1758740470) [ 7022.025880] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7023.727258] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7032.477594] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7043.717679] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7045.035710] Lustre: Mounted lustre-client [ 7050.216178] Lustre: lustre-OST0001-osc-ffff8e1258506000: Connection to lustre-OST0001 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7053.730756] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7063.981754] LustreError: 252339:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 7064.007247] Lustre: Unmounted lustre-client [ 7089.955133] Key type lgssc unregistered [ 7090.105389] LNet: 252742:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7090.109364] LNetError: 252742:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7090.119400] LNet: Removed LNI 192.168.203.37@tcp [ 7090.455639] Key type .llcrypt unregistered [ 7090.457216] Key type ._llcrypt unregistered [ 7111.274876] Key type ._llcrypt registered [ 7111.276992] Key type .llcrypt registered [ 7111.526291] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7111.533837] alg: No test for adler32 (adler32-zlib) [ 7112.432816] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 7112.555249] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 7114.159284] Key type lgssc registered [ 7114.703600] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7152.756934] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7154.524581] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7163.915175] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7196.790851] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 15:04:20 (1758740660) [ 7213.255414] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7214.724203] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7227.462370] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 15:04:51 (1758740691) [ 7240.656324] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7242.286263] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7250.065498] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7260.672740] Lustre: Mounted lustre-client [ 7264.746168] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7274.699944] LustreError: 260583:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7274.731353] Lustre: Unmounted lustre-client [ 7330.262882] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7331.750302] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7361.986747] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7372.796610] Lustre: Mounted lustre-client [ 7373.353120] LustreError: 262627:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12585da000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7373.363131] LustreError: 262627:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7373.365838] LustreError: 262627:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 7373.393424] Lustre: Unmounted lustre-client [ 7400.037398] Key type lgssc unregistered [ 7400.174437] LNet: 263030:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7400.178449] LNetError: 263030:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7400.187950] LNet: Removed LNI 192.168.203.37@tcp [ 7400.473402] Key type .llcrypt unregistered [ 7400.474805] Key type ._llcrypt unregistered [ 7411.665304] Key type ._llcrypt registered [ 7411.667036] Key type .llcrypt registered [ 7411.857697] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7411.865321] alg: No test for adler32 (adler32-zlib) [ 7412.766493] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 7412.870784] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 7414.479185] Key type lgssc registered [ 7415.020191] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7449.556640] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7451.136845] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7459.770967] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7485.537538] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 7486.177899] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 15:09:10 (1758740950) [ 7499.144630] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7500.758368] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7507.867448] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7514.099477] Lustre: Mounted lustre-client [ 7514.820869] LustreError: 269064:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12458cb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7514.828950] LustreError: 269064:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7514.856131] Lustre: Unmounted lustre-client [ 7532.944679] Key type lgssc unregistered [ 7533.102658] LNet: 269466:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7533.106275] LNetError: 269466:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7533.117216] LNet: Removed LNI 192.168.203.37@tcp [ 7533.405923] Key type .llcrypt unregistered [ 7533.407077] Key type ._llcrypt unregistered [ 7539.528362] Key type ._llcrypt registered [ 7539.530113] Key type .llcrypt registered [ 7540.074609] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 7540.760759] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 15:10:04 (1758741004) [ 7544.241484] Key type .llcrypt unregistered [ 7544.243169] Key type ._llcrypt unregistered [ 7547.440469] Key type ._llcrypt registered [ 7547.442122] Key type .llcrypt registered [ 7547.664176] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7547.671552] alg: No test for adler32 (adler32-zlib) [ 7548.592519] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 7548.698200] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 7550.311205] Key type lgssc registered [ 7550.776398] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7570.684082] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7581.172345] Lustre: Mounted lustre-client [ 7581.745938] LustreError: 272474:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12469a3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7581.754442] LustreError: 272474:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7581.781391] Lustre: Unmounted lustre-client [ 7599.260832] Key type lgssc unregistered [ 7599.391484] LNet: 272875:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7599.394331] LNetError: 272875:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7599.405740] LNet: Removed LNI 192.168.203.37@tcp [ 7599.650540] Key type .llcrypt unregistered [ 7599.651704] Key type ._llcrypt unregistered [ 7604.872301] Key type ._llcrypt registered [ 7604.873651] Key type .llcrypt registered [ 7605.398466] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 15:11:09 (1758741069) [ 7606.244250] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7606.254395] alg: No test for adler32 (adler32-zlib) [ 7607.138957] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 7607.231341] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 7608.815151] Key type lgssc registered [ 7609.246106] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7674.907698] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7685.850662] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7687.201617] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7689.421713] Lustre: Mounted lustre-client [ 7689.920442] LustreError: 275914:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1243bc2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7689.928435] LustreError: 275914:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7689.949159] Lustre: Unmounted lustre-client [ 7707.768209] Key type lgssc unregistered [ 7707.887581] LNet: 276316:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7707.890485] LNetError: 276316:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7707.903808] LNet: Removed LNI 192.168.203.37@tcp [ 7708.186151] Key type .llcrypt unregistered [ 7708.187585] Key type ._llcrypt unregistered [ 7714.065983] Key type ._llcrypt registered [ 7714.067702] Key type .llcrypt registered [ 7714.593928] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 15:12:58 (1758741178) [ 7715.524559] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7715.534689] alg: No test for adler32 (adler32-zlib) [ 7716.408806] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 7716.495460] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 7718.079225] Key type lgssc registered [ 7718.487256] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7737.500646] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7738.965934] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7746.136919] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7756.787963] Lustre: Mounted lustre-client [ 7761.889664] Lustre: lustre-MDT0000-mdc-ffff8e1243c71000: Connection to lustre-MDT0000 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7764.719540] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7764.732292] LustreError: 279378:0:(file.c:6101:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 7764.852883] LustreError: 279397:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1243c71000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7764.857911] LustreError: MGC192.168.203.137@tcp: Connection to MGS (at 192.168.203.137@tcp) was lost; in progress operations using this service will fail [ 7764.863930] LustreError: 279397:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7764.884111] Lustre: Unmounted lustre-client [ 7776.372894] Key type lgssc unregistered [ 7776.497499] LNet: 279790:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7776.500895] LNetError: 279790:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7776.508379] LNet: Removed LNI 192.168.203.37@tcp [ 7776.772549] Key type .llcrypt unregistered [ 7776.774192] Key type ._llcrypt unregistered [ 7782.855728] Key type ._llcrypt registered [ 7782.857356] Key type .llcrypt registered [ 7783.430695] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 15:14:07 (1758741247) [ 7784.405741] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7784.413095] alg: No test for adler32 (adler32-zlib) [ 7785.295433] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 7785.390643] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 7786.983175] Key type lgssc registered [ 7787.402588] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7805.514397] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7806.869204] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7814.022567] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7824.370308] Lustre: Mounted lustre-client [ 7829.473880] Lustre: lustre-MDT0001-mdc-ffff8e1251483000: Connection to lustre-MDT0001 (at 192.168.203.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7832.200348] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7832.657302] LustreError: 282879:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1251483000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7832.668976] LustreError: 282879:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7832.696747] Lustre: Unmounted lustre-client [ 7844.149621] Key type lgssc unregistered [ 7844.275490] LNet: 283272:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7844.278786] LNetError: 283272:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7844.287106] LNet: Removed LNI 192.168.203.37@tcp [ 7844.557767] Key type .llcrypt unregistered [ 7844.559024] Key type ._llcrypt unregistered [ 7850.341767] Key type ._llcrypt registered [ 7850.342932] Key type .llcrypt registered [ 7850.837423] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 15:15:15 (1758741315) [ 7857.507287] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7857.554487] alg: No test for adler32 (adler32-zlib) [ 7858.427803] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 7858.536558] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 7860.143140] Key type lgssc registered [ 7860.662135] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7903.622109] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7904.821615] Lustre: Mounted lustre-client [ 7926.608506] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7936.872799] LustreError: 288608:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 7936.886717] Lustre: Unmounted lustre-client [ 7963.160237] Key type lgssc unregistered [ 7963.308571] LNet: 289009:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7963.312037] LNetError: 289009:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7963.320132] LNet: Removed LNI 192.168.203.37@tcp [ 7963.602074] Key type .llcrypt unregistered [ 7963.603572] Key type ._llcrypt unregistered [ 7969.456680] Key type ._llcrypt registered [ 7969.457715] Key type .llcrypt registered [ 7969.974178] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 15:17:14 (1758741434) [ 7970.563727] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 7971.180479] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 15:17:15 (1758741435) [ 7971.794296] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 7972.458199] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 15:17:16 (1758741436) [ 7973.086819] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 7973.726166] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 15:17:17 (1758741437) [ 7974.366865] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 7974.992767] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 15:17:19 (1758741439) [ 7975.629177] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 7976.284403] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 15:17:20 (1758741440) [ 7979.544383] Key type .llcrypt unregistered [ 7979.545552] Key type ._llcrypt unregistered [ 7982.066562] Key type ._llcrypt registered [ 7982.067949] Key type .llcrypt registered [ 7982.305180] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7982.311791] alg: No test for adler32 (adler32-zlib) [ 7983.176807] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 7983.273286] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 7984.863209] Key type lgssc registered [ 7985.266585] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8015.115072] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8016.582195] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8025.474310] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8032.222729] Lustre: Mounted lustre-client [ 8032.859436] LustreError: 294587:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1247364800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8032.867206] LustreError: 294587:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8032.899207] Lustre: Unmounted lustre-client [ 8057.027501] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 15:18:41 (1758741521) [ 8068.862185] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8070.150298] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8077.347848] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8088.052564] Lustre: Mounted lustre-client [ 8088.392212] LustreError: 296698:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e1249160000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8088.400436] LustreError: 296698:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8088.403028] LustreError: 296698:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 8088.427155] Lustre: Unmounted lustre-client [ 8100.017496] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 15:19:24 (1758741564) [ 8129.811643] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8131.033565] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8137.929979] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8178.132619] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 15:20:42 (1758741642) [ 8182.537990] Key type lgssc unregistered [ 8182.671522] LNet: 302132:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8182.674702] LNetError: 302132:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8210.342641] LNet: Removed LNI 192.168.203.37@tcp [ 8210.619943] Key type .llcrypt unregistered [ 8210.621369] Key type ._llcrypt unregistered [ 8337.641103] Key type ._llcrypt registered [ 8337.642488] Key type .llcrypt registered [ 8337.849100] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8337.856996] alg: No test for adler32 (adler32-zlib) [ 8338.727272] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 8338.818278] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 8340.415277] Key type lgssc registered [ 8340.860025] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8348.756479] Lustre: DEBUG MARKER: SKIP: conf-sanity test_73c unable to configure net [ 8352.591982] Key type lgssc unregistered [ 8352.714468] LNet: 303820:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8352.718217] LNetError: 303820:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8352.727393] LNet: Removed LNI 192.168.203.37@tcp [ 8352.978608] Key type .llcrypt unregistered [ 8352.980148] Key type ._llcrypt unregistered [ 8356.523822] Key type ._llcrypt registered [ 8356.524783] Key type .llcrypt registered [ 8356.968622] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 15:23:41 (1758741821) [ 8363.560130] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8363.623770] alg: No test for adler32 (adler32-zlib) [ 8364.476374] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 8364.546299] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 8366.127185] Key type lgssc registered [ 8366.482502] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8383.599497] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 15:24:07 (1758741847) [ 8387.637246] Key type lgssc unregistered [ 8387.755457] LNet: 307360:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8387.757845] LNetError: 307360:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8387.767334] LNet: Removed LNI 192.168.203.37@tcp [ 8387.990405] Key type .llcrypt unregistered [ 8387.991459] Key type ._llcrypt unregistered [ 8391.932979] Key type ._llcrypt registered [ 8391.934266] Key type .llcrypt registered [ 8392.098266] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8392.105991] alg: No test for adler32 (adler32-zlib) [ 8392.975393] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 8393.057930] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 8394.655156] Key type lgssc registered [ 8395.054773] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8416.522483] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8417.832640] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8425.602749] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8429.357521] LNet: Added LNI 192.168.203.37@tcp42 [8/256/0/180] [ 8430.185847] LNet: Removed LNI 192.168.203.37@tcp [ 8431.597674] Lustre: 310246:0:(ldlm_lib.c:532:client_obd_setup()) lustre-MDT0000-mdc-ffff8e12469a7800: config has no valid NIDs, force dynamic NIDs [ 8432.647130] Lustre: Mounted lustre-client [ 8432.666089] LustreError: 310261:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e12469a7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8432.673287] LustreError: 310261:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8432.693131] Lustre: Unmounted lustre-client [ 8460.173445] Key type lgssc unregistered [ 8460.324887] LNet: 311101:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8460.327907] LNetError: 311101:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8460.336890] LNet: Removed LNI 192.168.203.37@tcp42 [ 8460.571883] Key type .llcrypt unregistered [ 8460.573528] Key type ._llcrypt unregistered [ 8464.343820] Key type ._llcrypt registered [ 8464.344852] Key type .llcrypt registered [ 8464.810590] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 15:25:29 (1758741929) [ 8465.607256] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8465.616419] alg: No test for adler32 (adler32-zlib) [ 8466.477214] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 8466.564943] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 8468.151173] Key type lgssc registered [ 8468.569747] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8486.531845] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8487.717406] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8493.699622] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8509.426264] Lustre: Mounted lustre-client [ 8530.515084] Lustre: Mounted fs15246-client [ 8535.315563] LustreError: 315222:0:(lov_obd.c:784:lov_cleanup()) fs15246-clilov-ffff8e1258e3e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8535.323732] LustreError: 315222:0:(obd_class.h:479:obd_check_dev()) Device 8 not setup [ 8535.335971] Lustre: Unmounted fs15246-client [ 8548.128102] LustreError: 315439:0:(lov_obd.c:784:lov_cleanup()) lustre-clilov-ffff8e124a66c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8548.131954] LustreError: 315439:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8548.134214] LustreError: 315439:0:(obd_class.h:479:obd_check_dev()) Skipped 3 previous similar messages [ 8548.152142] Lustre: Unmounted lustre-client [ 8565.328075] Key type lgssc unregistered [ 8565.449567] LNet: 315840:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8565.451928] LNetError: 315840:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8565.462125] LNet: Removed LNI 192.168.203.37@tcp [ 8565.701543] Key type .llcrypt unregistered [ 8565.702984] Key type ._llcrypt unregistered [ 8569.487575] Key type ._llcrypt registered [ 8569.489060] Key type .llcrypt registered [ 8569.925604] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 15:27:14 (1758742034) [ 8570.519074] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8570.536737] alg: No test for adler32 (adler32-zlib) [ 8571.387553] Lustre: Lustre: Build Version: 2.16.58_51_g2f926bd [ 8571.484975] LNet: Added LNI 192.168.203.37@tcp [8/256/0/180] [ 8573.071164] Key type lgssc registered [ 8573.442068] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8619.724443] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8621.042360] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8628.760282] Lustre: DEBUG MARKER: oleg337-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8679.212874] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 8465 sec ========== 15:29:03 (1758742143) [ 8679.788925] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 15:29:04 (1758742144) === [ 8680.926945] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 15:29:05 (1758742145) === [ 8692.223985] Key type lgssc unregistered [ 8692.337548] LNet: 324977:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8692.340511] LNetError: 324977:0:(acceptor.c:263:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8692.347945] LNet: Removed LNI 192.168.203.37@tcp [ 8692.605494] Key type .llcrypt unregistered [ 8692.606572] Key type ._llcrypt unregistered