[ 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 459707440 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2400.000 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f5b50-0x000f5b5f] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F5970 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE1BB7 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE1A53 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 001A13 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE1AC7 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE1B57 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE1B8F 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe1a53-0xbffe1ac6] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1a52] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe1ac7-0xbffe1b56] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe1b57-0xbffe1b8e] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe1b8f-0xbffe1bb6] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 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.001008] APIC: Switch to symmetric I/O mode setup [ 0.002230] x2apic enabled [ 0.003004] Switched APIC routing to physical x2apic. [ 0.004006] kvm-guest: setup PV IPIs [ 0.006978] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 0.007018] Calibrating delay loop (skipped) preset value.. 4800.00 BogoMIPS (lpj=2400000) [ 0.008014] pid_max: default: 32768 minimum: 301 [ 0.009114] LSM: Security Framework initializing [ 0.010036] Yama: becoming mindful. [ 0.011022] SELinux: Initializing. [ 0.012052] *** VALIDATE selinux *** [ 0.020002] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024626] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025129] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026069] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027081] *** VALIDATE tmpfs *** [ 0.028436] *** VALIDATE proc *** [ 0.030045] *** VALIDATE cgroup *** [ 0.031007] *** VALIDATE cgroup2 *** [ 0.032302] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.034157] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.035005] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.036022] Spectre V2 : User space: Vulnerable [ 0.037007] Speculative Store Bypass: Vulnerable [ 0.040271] debug: unmapping init [mem 0xffffffff91259000-0xffffffff91260fff] [ 0.042645] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043498] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044010] ... version: 2 [ 0.045007] ... bit width: 48 [ 0.046007] ... generic registers: 4 [ 0.047007] ... value mask: 0000ffffffffffff [ 0.048011] ... max period: 00007fffffffffff [ 0.049008] ... fixed-purpose events: 3 [ 0.050006] ... event mask: 000000070000000f [ 0.052218] rcu: Hierarchical SRCU implementation. [ 0.054479] smp: Bringing up secondary CPUs ... [ 0.055529] x86: Booting SMP configuration: [ 0.056018] .... node #0, CPUs: #1 #2 #3 [ 0.059499] smp: Brought up 1 node, 4 CPUs [ 0.061040] smpboot: Max logical packages: 1 [ 0.062024] smpboot: Total of 4 processors activated (19200.00 BogoMIPS) [ 0.181106] node 0 deferred pages initialised in 117ms [ 0.184344] devtmpfs: initialized [ 0.185247] x86/mm: Memory block size: 128MB [ 0.187253] gcov: version magic: 0x41383552 [ 0.190216] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.193090] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.195282] pinctrl core: initialized pinctrl subsystem [ 0.197118] [ 0.197620] ************************************************************* [ 0.200011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.202008] ** ** [ 0.204010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.206010] ** ** [ 0.208010] ** This means that this kernel is built to expose internal ** [ 0.210009] ** IOMMU data structures, which may compromise security on ** [ 0.213008] ** your system. ** [ 0.215007] ** ** [ 0.217009] ** If you see this message and you are not debugging the ** [ 0.219007] ** kernel, report this immediately to your vendor! ** [ 0.221006] ** ** [ 0.223007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.225007] ************************************************************* [ 0.227627] NET: Registered protocol family 16 [ 0.229449] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.231056] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.234091] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.238045] cpuidle: using governor menu [ 0.239280] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.241458] PCI: Using configuration type 1 for base access [ 0.243142] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.252133] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.255027] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.258038] cryptd: max_cpu_qlen set to 1000 [ 0.260168] ACPI: Added _OSI(Module Device) [ 0.261014] ACPI: Added _OSI(Processor Device) [ 0.262011] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.264010] ACPI: Added _OSI(Processor Aggregator Device) [ 0.266978] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.272749] ACPI: Interpreter enabled [ 0.274070] ACPI: PM: (supports S0 S3 S4 S5) [ 0.276010] ACPI: Using IOAPIC for interrupt routing [ 0.277088] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.279253] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.285628] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.287019] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.288008] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.290068] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.294060] acpiphp: Slot [2] registered [ 0.294986] acpiphp: Slot [3] registered [ 0.296051] acpiphp: Slot [4] registered [ 0.297051] acpiphp: Slot [5] registered [ 0.297850] acpiphp: Slot [6] registered [ 0.298092] acpiphp: Slot [7] registered [ 0.298865] acpiphp: Slot [8] registered [ 0.300048] acpiphp: Slot [9] registered [ 0.301069] acpiphp: Slot [10] registered [ 0.303069] acpiphp: Slot [11] registered [ 0.304045] acpiphp: Slot [12] registered [ 0.305142] acpiphp: Slot [13] registered [ 0.306066] acpiphp: Slot [14] registered [ 0.306898] acpiphp: Slot [15] registered [ 0.308052] acpiphp: Slot [16] registered [ 0.308874] acpiphp: Slot [17] registered [ 0.309056] acpiphp: Slot [18] registered [ 0.309946] acpiphp: Slot [19] registered [ 0.311100] acpiphp: Slot [20] registered [ 0.313074] acpiphp: Slot [21] registered [ 0.315118] acpiphp: Slot [22] registered [ 0.316073] acpiphp: Slot [23] registered [ 0.318062] acpiphp: Slot [24] registered [ 0.319060] acpiphp: Slot [25] registered [ 0.319967] acpiphp: Slot [26] registered [ 0.321062] acpiphp: Slot [27] registered [ 0.321906] acpiphp: Slot [28] registered [ 0.323044] acpiphp: Slot [29] registered [ 0.323877] acpiphp: Slot [30] registered [ 0.324058] acpiphp: Slot [31] registered [ 0.324922] PCI host bridge to bus 0000:00 [ 0.326012] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.328019] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.330015] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.331007] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.333011] pci_bus 0000:00: root bus resource [mem 0x180000000-0x1ffffffff window] [ 0.335012] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.336180] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.338688] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.341516] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.346389] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.348399] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.351013] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.353013] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.355018] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.357539] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.359715] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.362050] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.365531] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.369014] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.375671] pci 0000:00:02.0: reg 0x20: [mem 0xfebf4000-0xfebf7fff 64bit pref] [ 0.378007] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.383752] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.393034] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.397018] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.408016] pci 0000:00:05.0: reg 0x20: [mem 0xfebf8000-0xfebfbfff 64bit pref] [ 0.421833] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.427016] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.434017] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.449028] pci 0000:00:06.0: reg 0x20: [mem 0xfebfc000-0xfebfffff 64bit pref] [ 0.458236] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.460376] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.463379] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.465337] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.468196] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.472714] iommu: Default domain type: Passthrough [ 0.474483] SCSI subsystem initialized [ 0.476113] ACPI: bus type USB registered [ 0.477083] usbcore: registered new interface driver usbfs [ 0.478090] usbcore: registered new interface driver hub [ 0.479086] usbcore: registered new device driver usb [ 0.481161] pps_core: LinuxPPS API ver. 1 registered [ 0.483011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.485066] PTP clock support registered [ 0.487179] EDAC MC: Ver: 3.0.0 [ 0.488369] PCI: Using ACPI for IRQ routing [ 0.490787] NetLabel: Initializing [ 0.492007] NetLabel: domain hash size = 128 [ 0.494007] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.495061] NetLabel: unlabeled traffic allowed by default [ 0.497048] vgaarb: loaded [ 0.498268] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.499006] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.504010] clocksource: Switched to clocksource kvm-clock [ 0.608508] VFS: Disk quotas dquot_6.6.0 [ 0.609931] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.612281] *** VALIDATE ramfs *** [ 0.613466] *** VALIDATE hugetlbfs *** [ 0.614895] pnp: PnP ACPI init [ 0.617090] pnp: PnP ACPI: found 6 devices [ 0.632977] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.636478] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.638389] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.639892] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.642080] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.644296] pci_bus 0000:00: resource 8 [mem 0x180000000-0x1ffffffff window] [ 0.647025] NET: Registered protocol family 2 [ 0.649371] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.653502] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.656675] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.661657] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.664858] TCP: Hash tables configured (established 65536 bind 65536) [ 0.667682] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.670541] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.673150] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.675912] NET: Registered protocol family 1 [ 0.678249] RPC: Registered named UNIX socket transport module. [ 0.680209] RPC: Registered udp transport module. [ 0.681746] RPC: Registered tcp transport module. [ 0.683267] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.685404] NET: Registered protocol family 44 [ 0.686875] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.688827] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.690726] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.692771] PCI: CLS 0 bytes, default 64 [ 0.694446] Unpacking initramfs... [ 2.235286] debug: unmapping init [mem 0xffff9072fcc64000-0xffff9072fffcffff] [ 2.240913] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.243192] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.246402] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983777dd9, max_idle_ns: 440795300422 ns [ 2.793568] Initialise system trusted keyrings [ 2.795399] Key type blacklist registered [ 2.798353] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.810639] zbud: loaded [ 2.814506] *** VALIDATE nfs *** [ 2.815761] *** VALIDATE nfs4 *** [ 2.817524] pstore: using deflate compression [ 2.821816] Platform Keyring initialized [ 2.960277] NET: Registered protocol family 38 [ 2.961747] Key type asymmetric registered [ 2.963120] Asymmetric key parser 'x509' registered [ 2.964556] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.967701] io scheduler mq-deadline registered [ 2.969125] io scheduler kyber registered [ 2.970415] io scheduler bfq registered [ 2.971904] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.975368] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.977737] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.980239] ACPI: Power Button [PWRF] [ 3.096885] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.203065] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.319243] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.348560] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.381068] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.386453] Non-volatile memory driver v1.3 [ 3.387946] Linux agpgart interface v0.103 [ 3.420523] virtio_blk virtio1: [vda] 133248 512-byte logical blocks (68.2 MB/65.1 MiB) [ 3.424107] vda: detected capacity change from 0 to 68222976 [ 3.438539] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.442521] vdb: detected capacity change from 0 to 1073741824 [ 3.453766] libphy: Fixed MDIO Bus: probed [ 3.459855] usbcore: registered new interface driver usbserial_generic [ 3.462697] usbserial: USB Serial support registered for generic [ 3.465085] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.469885] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.471942] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.474467] mousedev: PS/2 mouse device common for all mice [ 3.477321] rtc_cmos 00:05: RTC can wake from S4 [ 3.479766] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.483701] rtc_cmos 00:05: registered as rtc0 [ 3.483761] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.483802] intel_pstate: CPU model not supported [ 3.488978] hid: raw HID events driver (C) Jiri Kosina [ 3.489173] usbcore: registered new interface driver usbhid [ 3.489177] usbhid: USB HID core driver [ 3.489318] drop_monitor: Initializing network drop monitor service [ 3.489457] Initializing XFRM netlink socket [ 3.489834] NET: Registered protocol family 10 [ 3.491708] Segment Routing with IPv6 [ 3.491740] NET: Registered protocol family 17 [ 3.493197] mpls_gso: MPLS GSO support [ 3.516931] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.527152] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.532487] RAS: Correctable Errors collector initialized. [ 3.534169] AVX version of gcm_enc/dec engaged. [ 3.535351] AES CTR mode by8 optimization enabled [ 3.655315] sched_clock: Marking stable (3655058180, 0)->(4374015475, -718957295) [ 3.658545] registered taskstats version 1 [ 3.660385] Loading compiled-in X.509 certificates [ 3.663594] zswap: loaded using pool lzo/zbud [ 3.697098] Key type big_key registered [ 3.710317] Key type encrypted registered [ 3.711645] ima: No TPM chip found, activating TPM-bypass! [ 3.713108] ima: Allocated hash algorithm: sha1 [ 3.714528] ima: No architecture policies found [ 3.715877] evm: Initialising EVM extended attributes: [ 3.717433] evm: security.selinux [ 3.718434] evm: security.ima [ 3.719282] evm: security.capability [ 3.720385] evm: HMAC attrs: 0x1 [ 3.723516] rtc_cmos 00:05: setting system clock to 2025-10-10 23:06:06 UTC (1760137566) [ 3.730440] debug: unmapping init [mem 0xffffffff92203000-0xffffffff923fffff] [ 3.733173] debug: unmapping init [mem 0xffffffff90f82000-0xffffffff91258fff] [ 3.745155] Write protecting the kernel read-only data: 28672k [ 3.750347] debug: unmapping init [mem 0xffffffff8f603000-0xffffffff8f7fffff] [ 3.753547] debug: unmapping init [mem 0xffffffff8ff14000-0xffffffff8fffffff] [ 3.799495] 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.808202] systemd[1]: Detected virtualization kvm. [ 3.809598] systemd[1]: Detected architecture x86-64. [ 3.812400] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.845558] systemd[1]: No hostname configured. [ 3.847137] systemd[1]: Set hostname to . [ 3.849079] random: systemd: uninitialized urandom read (16 bytes read) [ 3.851434] systemd[1]: Initializing machine ID from random generator. [ 3.997665] random: systemd: uninitialized urandom read (16 bytes read) [ 4.000635] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 4.006082] random: systemd: uninitialized urandom read (16 bytes read) [ 4.009145] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 4.015982] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Timers. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Local File Systems. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on Journal Socket. Starting Setup Virtual Console... [ OK ] Reached target Sockets. Starting Journal Service... Starting Create Volatile Files and Directories... Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create list of required sta…vice nodes for the current kernel. 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.060470] device-mapper: uevent: version 1.0.3 [ 5.065673] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 6.302883] virtio_net virtio0 ens2: renamed from eth0 [ 6.314331] random: fast init done [ 6.843499] scsi host0: ata_piix [ 6.963495] scsi host1: ata_piix [ 6.968729] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 6.975405] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 11.237638] random: crng init done [ 11.238997] random: 7 urandom warning(s) missed due to ratelimiting [ 12.028083] dracut-initqueue[591]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 12.899741] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Swap. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ 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 Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 14.506789] printk: systemd: 26 output lines suppressed due to ratelimiting [ 14.879589] SELinux: Disabled at runtime. [ 14.954962] 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) [ 14.964582] systemd[1]: Detected virtualization kvm. [ 14.966415] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 15.773226] systemd[1]: initrd-switch-root.service: Succeeded. [ 15.777481] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 15.789580] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 15.803412] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 15.811844] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 15.826018] systemd[1]: Starting Journal Service... Starting Journal Service... [ 15.840159] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Stopped target Switch Root. [ OK ] Listening on udev Kernel Socket. Mounting POSIX Message Queue File System... [ OK ] Stopped target Initrd File Systems. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [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... [ OK ] Created slice system-getty.slice. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on initctl Compatibility Named Pipe. Starting Remount Root and Kernel File Systems... Mounting Kernel Debug File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Mounting Huge Pages File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Reached target rpc_pipefs.target. [ OK ] Reached target Local Encrypted Volumes. Starting Apply Kernel Variables... Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-re[ 16.248753] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS mount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 16.775861] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 17.518554] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 17.608858] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 17.984860] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 18.192246] EDAC sbridge: Ver: 1.1.2 [ 20.708779] Key type dns_resolver registered [ 21.085878] NFS: Registering the id_resolver key type [ 21.088203] Key type id_resolver registered [ 21.090539] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. [ OK ] Started Daily Cleanup of Temporary Directories. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ 23.970787] hrtimer: interrupt took 7320725 ns [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg454-client login: [ 47.932983] libcfs: loading out-of-tree module taints kernel. [ 47.948781] Key type ._llcrypt registered [ 47.950395] Key type .llcrypt registered [ 48.201513] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 48.207344] alg: No test for adler32 (adler32-zlib) [ 49.155397] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 49.415993] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 51.016169] Key type lgssc registered [ 51.557993] Lustre: Echo OBD driver; http://www.lustre.org/ [ 111.338479] Lustre: Mounted lustre-client [ 113.810549] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 125.460764] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing check_logdir /tmp/testlogs/ [ 126.991684] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing yml_node [ 128.491914] Lustre: DEBUG MARKER: Client: 2.16.58.105 [ 129.360504] Lustre: DEBUG MARKER: MDS: 2.16.58.105 [ 130.225105] Lustre: DEBUG MARKER: OSS: 2.16.58.105 [ 130.793872] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Oct 10 19:08:13 EDT 2025 [ 136.539983] Lustre: DEBUG MARKER: excepting tests: 102 106 115 32newtarball [ 137.041108] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 137.185159] Lustre: lustre-OST0000-osc-ffff907350b01800: disconnect after 24s idle [ 137.608734] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 147.879538] LustreError: 8974:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 147.893177] Lustre: Unmounted lustre-client [ 193.910022] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 195.144827] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 202.851741] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 231.192922] Lustre: DEBUG MARKER: == conf-sanity test 76a: set permanent params with lctl across mounts ========================================================== 19:09:53 (1760137793) [ 241.179198] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 242.351293] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 248.584942] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 259.062868] Lustre: Mounted lustre-client [ 263.290095] LustreError: 14196:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff90735815f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 263.296950] LustreError: 14196:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 263.298939] LustreError: 14196:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 263.321936] Lustre: Unmounted lustre-client [ 311.505985] Lustre: Mounted lustre-client [ 313.806523] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 324.794984] LustreError: 16752:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907347053800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 324.802618] LustreError: 16752:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 324.804631] LustreError: 16752:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 324.829127] Lustre: Unmounted lustre-client [ 381.078857] Lustre: Mounted lustre-client [ 383.525600] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 390.730485] LustreError: 18978:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907350a3f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 390.734326] LustreError: 18978:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 390.739717] LustreError: 18978:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 390.742135] LustreError: 18978:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 390.768209] Lustre: Unmounted lustre-client [ 424.756988] Lustre: DEBUG MARKER: == conf-sanity test 76b: verify params log setup correctly ========================================================== 19:13:07 (1760137987) [ 452.884849] Lustre: Mounted lustre-client [ 455.324952] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 462.244726] LustreError: 22190:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907358156800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 462.249745] LustreError: 22190:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 462.254936] LustreError: 22190:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 462.257302] LustreError: 22190:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 462.287597] Lustre: Unmounted lustre-client [ 496.431700] Lustre: DEBUG MARKER: == conf-sanity test 76c: verify changelog_mask is applied with lctl set_param -P ========================================================== 19:14:18 (1760138058) [ 520.774619] Lustre: Mounted lustre-client [ 523.076703] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 530.914217] Lustre: lustre-MDT0000-mdc-ffff907350a3e000: Connection to lustre-MDT0000 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 541.155155] Lustre: lustre-MDT0001-mdc-ffff907350a3e000: Connection to lustre-MDT0001 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 546.272820] Lustre: lustre-OST0000-osc-ffff907350a3e000: disconnect after 25s idle [ 546.275660] Lustre: Skipped 1 previous similar message [ 551.394083] LustreError: MGC192.168.204.154@tcp: Connection to MGS (at 192.168.204.154@tcp) was lost; in progress operations using this service will fail [ 551.400804] Lustre: Evicted from MGS (at 192.168.204.154@tcp) after server handle changed from 0xa12ec74092be1046 to 0xa12ec74092be12a7 [ 551.404360] Lustre: MGC192.168.204.154@tcp: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 555.040918] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 571.876282] LustreError: lustre-MDT0000-mdc-ffff907350a3e000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 571.881484] Lustre: lustre-MDT0000-mdc-ffff907350a3e000: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 572.963691] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 17 sec [ 574.249912] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 574.810267] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 575.409105] LustreError: 26606:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907350a3e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 575.413956] LustreError: 26606:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 575.417826] LustreError: 26606:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 575.419728] LustreError: 26606:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 575.445150] Lustre: Unmounted lustre-client [ 609.266423] Lustre: DEBUG MARKER: == conf-sanity test 76d: verify llite.*.xattr_cache can be set by 'lctl set_param -P' correctly ========================================================== 19:16:11 (1760138171) [ 633.786414] Lustre: Mounted lustre-client [ 636.094133] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 644.789032] LustreError: 29664:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907348cf2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 644.792630] LustreError: 29664:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 644.797279] LustreError: 29664:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 644.799760] LustreError: 29664:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 644.822151] Lustre: Unmounted lustre-client [ 679.646519] Lustre: DEBUG MARKER: == conf-sanity test 77: comma-separated MGS NIDs and failover node NIDs ========================================================== 19:17:21 (1760138241) [ 680.433454] Lustre: DEBUG MARKER: SKIP: conf-sanity test_77 mixed loopback and real device not working [ 681.011141] Lustre: DEBUG MARKER: == conf-sanity test 78: run resize2fs on MDT and OST filesystems ========================================================== 19:17:23 (1760138243) [ 698.634027] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 706.208152] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 706.359938] Lustre: Mounted lustre-client [ 706.361357] Lustre: Skipped 2 previous similar messages [ 706.877073] Lustre: DEBUG MARKER: create test files [ 716.296374] LustreError: 33287:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907358151800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 716.301156] LustreError: 33287:0:(lov_obd.c:783:lov_cleanup()) Skipped 5 previous similar messages [ 716.333577] LustreError: 33287:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 716.336060] LustreError: 33287:0:(obd_class.h:479:obd_check_dev()) Skipped 27 previous similar messages [ 716.374125] Lustre: Unmounted lustre-client [ 716.375833] Lustre: Skipped 2 previous similar messages [ 726.303610] Key type lgssc unregistered [ 726.430524] LNet: 33637:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 726.433862] LNetError: 33637:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 726.446461] LNet: Removed LNI 192.168.204.54@tcp [ 726.719129] Key type .llcrypt unregistered [ 726.720105] Key type ._llcrypt unregistered [ 734.420674] Key type ._llcrypt registered [ 734.421882] Key type .llcrypt registered [ 734.705163] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 734.710871] alg: No test for adler32 (adler32-zlib) [ 735.571821] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 735.663942] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 737.256192] Key type lgssc registered [ 737.655389] Lustre: Echo OBD driver; http://www.lustre.org/ [ 749.841905] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 755.523710] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 761.816951] Lustre: Mounted lustre-client [ 763.613037] Lustre: DEBUG MARKER: check files after expanding the MDT and OST filesystems [ 765.142351] Lustre: DEBUG MARKER: create more files after expanding the MDT and OST filesystems [ 766.190160] LustreError: 36093:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9073457c2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 766.219946] LustreError: 36093:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 766.251115] Lustre: Unmounted lustre-client [ 775.924400] Key type lgssc unregistered [ 776.038526] LNet: 36442:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 776.041622] LNetError: 36442:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 776.048669] LNet: Removed LNI 192.168.204.54@tcp [ 776.286556] Key type .llcrypt unregistered [ 776.287599] Key type ._llcrypt unregistered [ 784.453560] Key type ._llcrypt registered [ 784.457440] Key type .llcrypt registered [ 784.724667] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 784.729861] alg: No test for adler32 (adler32-zlib) [ 785.584766] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 785.667162] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 787.248165] Key type lgssc registered [ 787.658234] Lustre: Echo OBD driver; http://www.lustre.org/ [ 800.629585] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 806.649554] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 813.017874] Lustre: Mounted lustre-client [ 814.844110] Lustre: DEBUG MARKER: check files after shrinking the MDT and OST filesystems [ 816.353443] LustreError: 38779:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907346af5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 816.377128] LustreError: 38779:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 816.410192] Lustre: Unmounted lustre-client [ 824.258541] Key type lgssc unregistered [ 824.379450] LNet: 39128:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 824.382458] LNetError: 39128:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 824.394573] LNet: Removed LNI 192.168.204.54@tcp [ 824.636798] Key type .llcrypt unregistered [ 824.637917] Key type ._llcrypt unregistered [ 834.428285] Key type ._llcrypt registered [ 834.430108] Key type .llcrypt registered [ 834.617602] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 834.622754] alg: No test for adler32 (adler32-zlib) [ 835.481755] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 835.569757] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 837.152121] Key type lgssc registered [ 837.508095] Lustre: Echo OBD driver; http://www.lustre.org/ [ 866.697491] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 867.958726] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 875.542396] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 897.017756] Lustre: DEBUG MARKER: == conf-sanity test 79: format MDT/OST without mgs option (should return errors) ========================================================== 19:20:59 (1760138459) [ 939.789524] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 940.947613] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 948.453811] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 979.824175] Lustre: DEBUG MARKER: == conf-sanity test 80: mgc import reconnect race ======== 19:22:22 (1760138542) [ 990.458450] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 991.863660] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 998.036808] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1040.899139] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 1076.819955] Lustre: DEBUG MARKER: == conf-sanity test 81: sparse OST indexing ============== 19:23:59 (1760138639) [ 1077.304712] Lustre: DEBUG MARKER: SKIP: conf-sanity test_81 needs >= 3 OSTs [ 1077.868571] Lustre: DEBUG MARKER: == conf-sanity test 82a: specify OSTs for file (succeed) or directory (succeed) ========================================================== 19:24:00 (1760138640) [ 1078.419513] Lustre: DEBUG MARKER: SKIP: conf-sanity test_82a needs >= 3 OSTs [ 1079.043075] Lustre: DEBUG MARKER: == conf-sanity test 82b: specify OSTs for file with --pool and --ost-list options ========================================================== 19:24:01 (1760138641) [ 1079.646754] Lustre: DEBUG MARKER: SKIP: conf-sanity test_82b needs >= 4 OSTs [ 1080.259618] Lustre: DEBUG MARKER: == conf-sanity test 83: ENOSPACE on OST doesn't cause message VFS: Busy inodes after unmount ... ========================================================== 19:24:02 (1760138642) [ 1080.838863] Lustre: DEBUG MARKER: mount the OST /dev/mapper/ost1_flakey as a ldiskfs filesystem [ 1083.297693] Lustre: DEBUG MARKER: run llverfs in partial mode on the OST ldiskfs /mnt/lustre-ost1 [ 1085.778115] Lustre: DEBUG MARKER: unmount the OST /dev/mapper/ost1_flakey [ 1127.294821] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1128.414822] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1135.675536] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1165.110559] Lustre: DEBUG MARKER: == conf-sanity test 84: check recovery_hard_time ========= 19:25:27 (1760138727) [ 1174.473211] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1175.625693] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1181.705167] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1201.794771] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 1206.908874] Lustre: Mounted lustre-client [ 1215.861227] Lustre: DEBUG MARKER: local REPLAY BARRIER on lustre-MDT0000 [ 1222.628737] Lustre: lustre-MDT0000-mdc-ffff907347052800: Connection to lustre-MDT0000 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1237.986451] LustreError: MGC192.168.204.154@tcp: Connection to MGS (at 192.168.204.154@tcp) was lost; in progress operations using this service will fail [ 1237.993918] Lustre: Evicted from MGS (at 192.168.204.154@tcp) after server handle changed from 0x491506550ee888de to 0x491506550ee94aa7 [ 1237.997895] Lustre: MGC192.168.204.154@tcp: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1242.154074] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) @@@ status 301, old was 0 req@000000000f45a1ff x1845638880831744/t8589934597(8589934597) o101->lustre-MDT0000-mdc-ffff907347052800@192.168.204.154@tcp:12/10 lens 592/608 e 0 to 0 dl 1760138820 ref 2 fl Interpret:RQU/604/0 rc 301/301 job:'' uid:0 gid:0 projid:0 [ 1242.786193] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) @@@ status 301, old was 0 req@000000001e4ed375 x1845638880832384/t8589934599(8589934599) o101->lustre-MDT0000-mdc-ffff907347052800@192.168.204.154@tcp:12/10 lens 592/608 e 0 to 0 dl 1760138821 ref 2 fl Interpret:RQU/604/0 rc 301/301 job:'' uid:0 gid:0 projid:0 [ 1244.058220] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) @@@ status 301, old was 0 req@000000002773c87a x1845638880833664/t8589934603(8589934603) o101->lustre-MDT0000-mdc-ffff907347052800@192.168.204.154@tcp:12/10 lens 592/608 e 0 to 0 dl 1760138822 ref 2 fl Interpret:RQU/604/0 rc 301/301 job:'' uid:0 gid:0 projid:0 [ 1244.069363] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) Skipped 1 previous similar message [ 1246.589846] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) @@@ status 301, old was 0 req@00000000364f88e3 x1845638880836224/t8589934611(8589934611) o101->lustre-MDT0000-mdc-ffff907347052800@192.168.204.154@tcp:12/10 lens 592/608 e 0 to 0 dl 1760138825 ref 2 fl Interpret:RQU/604/0 rc 301/301 job:'' uid:0 gid:0 projid:0 [ 1246.595388] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) Skipped 3 previous similar messages [ 1251.012418] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) @@@ status 301, old was 0 req@000000002865b094 x1845638880840704/t8589934625(8589934625) o101->lustre-MDT0000-mdc-ffff907347052800@192.168.204.154@tcp:12/10 lens 592/608 e 0 to 0 dl 1760138829 ref 2 fl Interpret:RQU/604/0 rc 301/301 job:'' uid:0 gid:0 projid:0 [ 1251.025709] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) Skipped 6 previous similar messages [ 1259.162974] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) @@@ status 301, old was 0 req@000000005580c76e x1845638880849024/t8589934651(8589934651) o101->lustre-MDT0000-mdc-ffff907347052800@192.168.204.154@tcp:12/10 lens 592/608 e 0 to 0 dl 1760138837 ref 2 fl Interpret:RQU/604/0 rc 301/301 job:'' uid:0 gid:0 projid:0 [ 1259.169284] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) Skipped 12 previous similar messages [ 1275.411155] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) @@@ status 301, old was 0 req@00000000b6d73d94 x1845638880865664/t8589934703(8589934703) o101->lustre-MDT0000-mdc-ffff907347052800@192.168.204.154@tcp:12/10 lens 592/608 e 0 to 0 dl 1760138853 ref 2 fl Interpret:RQU/604/0 rc 301/301 job:'' uid:0 gid:0 projid:0 [ 1275.427407] LustreError: 39737:0:(client.c:3408:ptlrpc_replay_interpret()) Skipped 25 previous similar messages [ 1297.578134] LustreError: lustre-MDT0000-mdc-ffff907347052800: operation mds_close to node 192.168.204.154@tcp failed: rc = -107 [ 1297.600652] Lustre: lustre-MDT0000-mdc-ffff907348d69800: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1301.480608] LustreError: lustre-MDT0000-mdc-ffff907347052800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1301.548630] LustreError: 60512:0:(file.c:6101:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -5 [ 1301.678395] Lustre: lustre-MDT0000-mdc-ffff907347052800: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1303.567684] LustreError: 60614:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907347052800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1303.571163] LustreError: 60614:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 1303.590176] Lustre: Unmounted lustre-client [ 1330.727185] Lustre: DEBUG MARKER: == conf-sanity test 85: osd_ost init: fail ea_fid_set ==== 19:28:12 (1760138892) [ 1383.306687] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1386.717475] Lustre: DEBUG MARKER: == conf-sanity test 86: Replacing mkfs.lustre -G option == 19:29:09 (1760138949) [ 1404.786619] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1444.554789] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1445.707250] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1453.050380] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1474.346322] Lustre: DEBUG MARKER: == conf-sanity test 87: check if MDT inode can hold EAs with N stripes properly ========================================================== 19:30:36 (1760139036) [ 1475.513346] Key type lgssc unregistered [ 1475.636571] LNet: 67787:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1475.640916] LNetError: 67787:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1475.650062] LNet: Removed LNI 192.168.204.54@tcp [ 1475.887103] Key type .llcrypt unregistered [ 1475.889075] Key type ._llcrypt unregistered [ 1485.455722] Key type ._llcrypt registered [ 1485.457166] Key type .llcrypt registered [ 1485.608708] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1485.615417] alg: No test for adler32 (adler32-zlib) [ 1486.462937] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1486.536176] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 1488.112135] Key type lgssc registered [ 1488.476172] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1526.228886] Lustre: Mounted lustre-client [ 1526.498065] LustreError: 71016:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907348cf7800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1526.504735] LustreError: 71016:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1526.518174] Lustre: Unmounted lustre-client [ 1541.321305] Lustre: DEBUG MARKER: == conf-sanity test 88: check the default mount options can be overridden ========================================================== 19:31:43 (1760139103) [ 1552.174807] Lustre: DEBUG MARKER: == conf-sanity test 89: check tunefs --param and --erase-param{s} options ========================================================== 19:31:54 (1760139114) [ 1590.902503] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL failover.node=192.0.2.254@tcp0,mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1592.011326] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL failover.node=192.0.2.254@tcp0,mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1599.598766] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) failover.node=192.0.2.254@tcp0,osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1616.764608] Lustre: DEBUG MARKER: == conf-sanity test 90a: check max_mod_rpcs_in_flight is enforced ========================================================== 19:32:59 (1760139179) [ 1626.563630] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1627.727536] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1633.802082] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1644.530058] Lustre: Mounted lustre-client [ 1662.944087] Lustre: 79260:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139209/real 1760139209] req@0000000035c230fc x1845639563472640/t0(0) o36->lustre-MDT0000-mdc-ffff9073441c9800@192.168.204.154@tcp:12/10 lens 488/512 e 0 to 1 dl 1760139225 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1662.944226] Lustre: lustre-MDT0000-mdc-ffff9073441c9800: Connection to lustre-MDT0000 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1662.949933] Lustre: 79260:0:(client.c:2468:ptlrpc_expire_one_request()) Skipped 3 previous similar messages [ 1662.965590] Lustre: lustre-MDT0000-mdc-ffff9073441c9800: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1679.840183] Lustre: 79296:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139226/real 1760139226] req@00000000969c11fd x1845639563479296/t0(0) o36->lustre-MDT0000-mdc-ffff9073441c9800@192.168.204.154@tcp:12/10 lens 488/512 e 0 to 1 dl 1760139242 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1679.840183] Lustre: 79294:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139226/real 1760139226] req@000000001a77062b x1845639563480320/t0(0) o36->lustre-MDT0000-mdc-ffff9073441c9800@192.168.204.154@tcp:12/10 lens 488/512 e 0 to 1 dl 1760139242 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1679.840207] Lustre: 79296:0:(client.c:2468:ptlrpc_expire_one_request()) Skipped 4 previous similar messages [ 1679.840281] Lustre: lustre-MDT0000-mdc-ffff9073441c9800: Connection to lustre-MDT0000 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1679.851267] Lustre: 79294:0:(client.c:2468:ptlrpc_expire_one_request()) Skipped 7 previous similar messages [ 1679.858046] Lustre: lustre-MDT0000-mdc-ffff9073441c9800: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1693.852728] LustreError: 79341:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9073441c9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1693.857584] LustreError: 79341:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 1693.867216] LustreError: 79341:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1693.870541] LustreError: 79341:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1693.891203] Lustre: Unmounted lustre-client [ 1711.319681] Key type lgssc unregistered [ 1711.454729] LNet: 79745:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1711.457096] LNetError: 79745:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1711.467941] LNet: Removed LNI 192.168.204.54@tcp [ 1711.737378] Key type .llcrypt unregistered [ 1711.739037] Key type ._llcrypt unregistered [ 1716.911884] Key type ._llcrypt registered [ 1716.913121] Key type .llcrypt registered [ 1717.361393] Lustre: DEBUG MARKER: == conf-sanity test 90b: check max_mod_rpcs_in_flight is enforced after update ========================================================== 19:34:39 (1760139279) [ 1718.244694] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1718.256265] alg: No test for adler32 (adler32-zlib) [ 1719.137543] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1719.221905] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 1720.816159] Key type lgssc registered [ 1721.253550] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1738.918663] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1740.128739] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1746.354960] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1761.779159] Lustre: Mounted lustre-client [ 1782.752132] Lustre: 82849:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139329/real 1760139329] req@00000000bf2631fe x1845639806723584/t0(0) o36->lustre-MDT0000-mdc-ffff907343023800@192.168.204.154@tcp:12/10 lens 488/512 e 0 to 1 dl 1760139345 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1782.758590] Lustre: lustre-MDT0000-mdc-ffff907343023800: Connection to lustre-MDT0000 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1782.766956] Lustre: lustre-MDT0000-mdc-ffff907343023800: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1799.648164] Lustre: 82894:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139346/real 1760139346] req@0000000017618695 x1845639806736896/t0(0) o36->lustre-MDT0001-mdc-ffff907343023800@192.168.204.154@tcp:12/10 lens 488/512 e 0 to 1 dl 1760139362 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1799.648515] Lustre: lustre-MDT0001-mdc-ffff907343023800: Connection to lustre-MDT0001 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1799.654506] Lustre: 82894:0:(client.c:2468:ptlrpc_expire_one_request()) Skipped 3 previous similar messages [ 1799.668933] Lustre: lustre-MDT0001-mdc-ffff907343023800: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1815.520196] Lustre: 82928:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139362/real 1760139362] req@00000000bf2631fe x1845639806743296/t0(0) o36->lustre-MDT0001-mdc-ffff907343023800@192.168.204.154@tcp:12/10 lens 488/512 e 0 to 1 dl 1760139378 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1815.520397] Lustre: lustre-MDT0001-mdc-ffff907343023800: Connection to lustre-MDT0001 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1815.534704] Lustre: 82928:0:(client.c:2468:ptlrpc_expire_one_request()) Skipped 3 previous similar messages [ 1815.552951] Lustre: lustre-MDT0001-mdc-ffff907343023800: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1816.524971] LustreError: 82982:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907343023800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1816.536391] LustreError: 82982:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1816.564380] Lustre: Unmounted lustre-client [ 1817.008789] Lustre: Mounted lustre-client [ 1833.440206] Lustre: 83082:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139380/real 1760139380] req@00000000543e3f59 x1845639806782720/t0(0) o36->lustre-MDT0000-mdc-ffff907348d85000@192.168.204.154@tcp:12/10 lens 488/512 e 0 to 1 dl 1760139396 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1833.440347] Lustre: lustre-MDT0000-mdc-ffff907348d85000: Connection to lustre-MDT0000 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1833.450361] Lustre: 83082:0:(client.c:2468:ptlrpc_expire_one_request()) Skipped 3 previous similar messages [ 1833.463678] Lustre: lustre-MDT0000-mdc-ffff907348d85000: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1849.312303] Lustre: 83147:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139396/real 1760139396] req@00000000a7557c95 x1845639806801536/t0(0) o36->lustre-MDT0000-mdc-ffff907348d85000@192.168.204.154@tcp:12/10 lens 488/512 e 0 to 1 dl 1760139412 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1849.312461] Lustre: lustre-MDT0000-mdc-ffff907348d85000: Connection to lustre-MDT0000 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1849.323869] Lustre: 83147:0:(client.c:2468:ptlrpc_expire_one_request()) Skipped 3 previous similar messages [ 1849.337050] Lustre: lustre-MDT0000-mdc-ffff907348d85000: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 1850.423431] LustreError: 83196:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907348d85000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1850.433676] LustreError: 83196:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1850.435503] LustreError: 83196:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1850.458155] Lustre: Unmounted lustre-client [ 1868.021881] Key type lgssc unregistered [ 1868.158815] LNet: 83596:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1868.162566] LNetError: 83596:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1868.172460] LNet: Removed LNI 192.168.204.54@tcp [ 1868.465603] Key type .llcrypt unregistered [ 1868.466851] Key type ._llcrypt unregistered [ 1873.916972] Key type ._llcrypt registered [ 1873.918548] Key type .llcrypt registered [ 1874.366313] Lustre: DEBUG MARKER: == conf-sanity test 90c: check max_mod_rpcs_in_flight update limits ========================================================== 19:37:16 (1760139436) [ 1875.039761] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1875.065097] alg: No test for adler32 (adler32-zlib) [ 1875.946342] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1876.036757] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 1877.624189] Key type lgssc registered [ 1878.065093] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1895.270332] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1896.497584] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1902.780468] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1913.329719] Lustre: Mounted lustre-client [ 1915.975675] LustreError: 86723:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907348d17000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1915.982120] LustreError: 86723:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1916.005462] Lustre: Unmounted lustre-client [ 1916.460649] Lustre: Mounted lustre-client [ 1916.526845] LustreError: 86786:0:(genops.c:2257:obd_set_max_mod_rpcs_in_flight()) lustre-MDT0000-mdc-ffff907358151000: can't set max_mod_rpcs_in_flight=9 higher than mdt.*.max_mod_rpcs_in_flight=8 returned by the MDT server at connection. [ 1917.404096] LustreError: 86821:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907358151000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1917.410041] LustreError: 86821:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1917.411709] LustreError: 86821:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1917.435151] Lustre: Unmounted lustre-client [ 1917.551095] Lustre: Mounted lustre-client [ 1918.758809] LustreError: 86931:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907358158800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1918.763727] LustreError: 86931:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1918.765878] LustreError: 86931:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1918.786599] Lustre: Unmounted lustre-client [ 1936.026736] Key type lgssc unregistered [ 1936.145571] LNet: 87333:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1936.148334] LNetError: 87333:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1936.158744] LNet: Removed LNI 192.168.204.54@tcp [ 1936.410151] Key type .llcrypt unregistered [ 1936.411083] Key type ._llcrypt unregistered [ 1941.749913] Key type ._llcrypt registered [ 1941.750953] Key type .llcrypt registered [ 1942.290885] Lustre: DEBUG MARKER: == conf-sanity test 90d: check one close RPC is allowed above max_mod_rpcs_in_flight ========================================================== 19:38:24 (1760139504) [ 1943.272312] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1943.290206] alg: No test for adler32 (adler32-zlib) [ 1944.145823] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 1944.232851] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 1945.816187] Key type lgssc registered [ 1946.273690] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1965.275948] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1966.527355] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1974.217398] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1985.015411] Lustre: Mounted lustre-client [ 2002.400174] Lustre: 90430:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1760139549/real 1760139549] req@000000001d39b55e x1845640043708288/t0(0) o36->lustre-MDT0000-mdc-ffff907347056000@192.168.204.154@tcp:12/10 lens 488/512 e 0 to 1 dl 1760139565 ref 2 fl Rpc:XQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 2002.400289] Lustre: lustre-MDT0000-mdc-ffff907347056000: Connection to lustre-MDT0000 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2002.406331] Lustre: 90430:0:(client.c:2468:ptlrpc_expire_one_request()) Skipped 3 previous similar messages [ 2002.416678] Lustre: lustre-MDT0000-mdc-ffff907347056000: Connection restored to 192.168.204.154@tcp (at 192.168.204.154@tcp) [ 2002.841682] LustreError: 90474:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907347056000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2002.851407] LustreError: 90474:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2002.874148] Lustre: Unmounted lustre-client [ 2020.612577] Key type lgssc unregistered [ 2020.751687] LNet: 90877:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2020.753934] LNetError: 90877:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2020.760781] LNet: Removed LNI 192.168.204.54@tcp [ 2021.025742] Key type .llcrypt unregistered [ 2021.026767] Key type ._llcrypt unregistered [ 2026.443509] Key type ._llcrypt registered [ 2026.444503] Key type .llcrypt registered [ 2026.904547] Lustre: DEBUG MARKER: == conf-sanity test 91: evict-by-nid support ============= 19:39:49 (1760139589) [ 2027.595617] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2027.602959] alg: No test for adler32 (adler32-zlib) [ 2028.472540] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2028.560660] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 2030.144118] Key type lgssc registered [ 2030.547200] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2049.831690] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2051.300878] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2058.997398] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2069.487878] Lustre: Mounted lustre-client [ 2071.072325] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2081.319453] LustreError: 93995:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2081.334119] Lustre: Unmounted lustre-client [ 2132.183334] Key type lgssc unregistered [ 2132.353698] LNet: 94474:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2132.358638] LNetError: 94474:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2132.373544] LNet: Removed LNI 192.168.204.54@tcp [ 2132.795454] Key type .llcrypt unregistered [ 2132.797621] Key type ._llcrypt unregistered [ 2139.127809] Key type ._llcrypt registered [ 2139.129659] Key type .llcrypt registered [ 2139.628698] Lustre: DEBUG MARKER: == conf-sanity test 92: ldev returns MGS NID correctly in command substitution ========================================================== 19:41:41 (1760139701) [ 2142.988921] Lustre: DEBUG MARKER: == conf-sanity test 93: register mulitple MDT at the same time ========================================================== 19:41:45 (1760139705) [ 2143.511359] Lustre: DEBUG MARKER: SKIP: conf-sanity test_93 needs >= 3 MDTs [ 2144.081297] Lustre: DEBUG MARKER: == conf-sanity test 94: ldev outputs correct labels for file system name query ========================================================== 19:41:46 (1760139706) [ 2146.711511] Lustre: DEBUG MARKER: == conf-sanity test 95: ldev should only allow one label filter ========================================================== 19:41:49 (1760139709) [ 2149.728870] Lustre: DEBUG MARKER: == conf-sanity test 96: ldev returns hostname and backend fs correctly in command sub ========================================================== 19:41:52 (1760139712) [ 2152.529602] Lustre: DEBUG MARKER: == conf-sanity test 97: ldev returns correct ouput when querying based on role ========================================================== 19:41:54 (1760139714) [ 2155.350811] Lustre: DEBUG MARKER: == conf-sanity test 98: Buffer-overflow check while parsing mount_opts ========================================================== 19:41:57 (1760139717) [ 2156.077298] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2156.125061] alg: No test for adler32 (adler32-zlib) [ 2156.986099] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2157.076119] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 2158.664182] Key type lgssc registered [ 2159.052393] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2176.200882] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2177.457835] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2184.139661] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2194.929635] Lustre: Mounted lustre-client [ 2196.668209] LustreError: 101785:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907348d80000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2196.675728] LustreError: 101785:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2196.694941] Lustre: Unmounted lustre-client [ 2213.989301] Key type lgssc unregistered [ 2214.115620] LNet: 102186:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2214.119468] LNetError: 102186:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2214.128040] LNet: Removed LNI 192.168.204.54@tcp [ 2214.377895] Key type .llcrypt unregistered [ 2214.378937] Key type ._llcrypt unregistered [ 2219.879586] Key type ._llcrypt registered [ 2219.880819] Key type .llcrypt registered [ 2220.384163] Lustre: DEBUG MARKER: == conf-sanity test 99: Adding meta_bg option ============ 19:43:02 (1760139782) [ 2221.171851] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2221.230827] alg: No test for adler32 (adler32-zlib) [ 2222.095040] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2222.183341] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 2223.768207] Key type lgssc registered [ 2224.215087] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2235.016123] Lustre: DEBUG MARKER: == conf-sanity test 100: check lshowmount lists MGS, MDT, OST and 0@lo ========================================================== 19:43:17 (1760139797) [ 2265.558154] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2266.683785] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2274.627377] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2275.788751] Lustre: Mounted lustre-client [ 2277.046981] LustreError: 107995:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907358e92000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2277.052721] LustreError: 107995:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2277.072906] Lustre: Unmounted lustre-client [ 2294.093094] Key type lgssc unregistered [ 2294.220773] LNet: 108397:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2294.223630] LNetError: 108397:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2294.231572] LNet: Removed LNI 192.168.204.54@tcp [ 2294.459596] Key type .llcrypt unregistered [ 2294.460646] Key type ._llcrypt unregistered [ 2299.339117] Key type ._llcrypt registered [ 2299.340267] Key type .llcrypt registered [ 2299.817225] Lustre: DEBUG MARKER: == conf-sanity test 101a: Race MDT->OST reconnection with create ========================================================== 19:44:22 (1760139862) [ 2300.577867] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2300.596349] alg: No test for adler32 (adler32-zlib) [ 2301.459529] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2301.556074] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 2303.144161] Key type lgssc registered [ 2303.561221] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2320.137561] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2321.234883] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2326.865926] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2333.145360] Lustre: Mounted lustre-client [ 2780.450213] LustreError: 120187:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907358e97800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2780.454149] LustreError: 120187:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2780.472234] Lustre: Unmounted lustre-client [ 2797.829260] Key type lgssc unregistered [ 2797.952486] LNet: 120590:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2797.956082] LNetError: 120590:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2797.962879] LNet: Removed LNI 192.168.204.54@tcp [ 2798.244996] Key type .llcrypt unregistered [ 2798.246702] Key type ._llcrypt unregistered [ 2803.434656] Key type ._llcrypt registered [ 2803.435671] Key type .llcrypt registered [ 2803.924695] Lustre: DEBUG MARKER: == conf-sanity test 101b: Race events DISCONNECT and ACTIVE in osp ========================================================== 19:52:46 (1760140366) [ 2804.655648] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2804.684230] alg: No test for adler32 (adler32-zlib) [ 2805.530810] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2805.610782] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 2807.208251] Key type lgssc registered [ 2807.663336] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2823.905862] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2824.992916] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2831.098042] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2832.417677] Lustre: Mounted lustre-client [ 2837.476413] Lustre: lustre-OST0000-osc-ffff907347194800: Connection to lustre-OST0000 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 2869.436820] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2878.158792] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 8 sec [ 2879.355562] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff907347194800.ost_server_uuid 50 [ 2879.850672] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff907347194800.ost_server_uuid in FULL state after 0 sec [ 2880.144576] LustreError: 124780:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907347194800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2880.150331] LustreError: 124780:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2880.169583] Lustre: Unmounted lustre-client [ 2897.308165] Key type lgssc unregistered [ 2897.418560] LNet: 125182:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2897.420888] LNetError: 125182:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2897.430697] LNet: Removed LNI 192.168.204.54@tcp [ 2897.659266] Key type .llcrypt unregistered [ 2897.660281] Key type ._llcrypt unregistered [ 2902.549325] Key type ._llcrypt registered [ 2902.551235] Key type .llcrypt registered [ 2903.151368] Lustre: DEBUG MARKER: SKIP: conf-sanity test_102 skipping excluded test 102 [ 2903.912898] Lustre: DEBUG MARKER: == conf-sanity test 103: rename filesystem name ========== 19:54:26 (1760140466) [ 2906.976708] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2907.035132] alg: No test for adler32 (adler32-zlib) [ 2907.916318] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 2908.005924] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 2909.600195] Key type lgssc registered [ 2910.030525] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2938.836385] Lustre: Mounted lustre-client [ 2941.016751] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 2956.076198] LustreError: 128657:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff90734845d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2956.083312] LustreError: 128657:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 2956.109235] Lustre: Unmounted lustre-client [ 3012.275439] Lustre: Mounted mylustre-client [ 3014.587300] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3024.271224] LustreError: 130973:0:(lov_obd.c:783:lov_cleanup()) mylustre-clilov-ffff907347196000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3024.275088] LustreError: 130973:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 3024.279633] LustreError: 130973:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3024.281355] LustreError: 130973:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3024.305154] Lustre: Unmounted mylustre-client [ 3081.266876] Lustre: Mounted tfs-client [ 3083.597884] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3090.923316] LustreError: 133277:0:(lov_obd.c:783:lov_cleanup()) tfs-clilov-ffff907358151000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3090.926201] LustreError: 133277:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 3090.930459] LustreError: 133277:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3090.933615] LustreError: 133277:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3090.959203] Lustre: Unmounted tfs-client [ 3158.511772] Lustre: Mounted lustre-client [ 3161.008649] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 3169.436972] Lustre: DEBUG MARKER: == conf-sanity test 104a: Make sure user defined options are reflected in mount ========================================================== 19:58:51 (1760140731) [ 3170.023182] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3180.263635] LustreError: 136147:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3180.265896] LustreError: 136147:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3180.281808] Lustre: Unmounted lustre-client [ 3248.082140] Lustre: client wants to enable acl, but mdt not! [ 3248.094918] Lustre: Mounted lustre-client [ 3250.070499] Lustre: DEBUG MARKER: == conf-sanity test 104b: Mount uses last flock argument ========================================================== 20:00:12 (1760140812) [ 3250.205293] Lustre: client wants to enable acl, but mdt not! [ 3250.537180] LustreError: 139552:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907347194800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3250.540010] LustreError: 139552:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 3250.544771] LustreError: 139552:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 3250.546541] LustreError: 139552:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3250.570138] Lustre: Unmounted lustre-client [ 3253.707205] Lustre: DEBUG MARKER: == conf-sanity test 105: check file creation for ro and rw bind mnt pt ========================================================== 20:00:16 (1760140816) [ 3253.974595] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3253.976684] Lustre: Skipped 3 previous similar messages [ 3264.230928] LustreError: 140272:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3264.232788] LustreError: 140272:0:(obd_class.h:479:obd_check_dev()) Skipped 23 previous similar messages [ 3264.247461] Lustre: Unmounted lustre-client [ 3264.248839] Lustre: Skipped 2 previous similar messages [ 3287.725167] Key type lgssc unregistered [ 3287.858598] LNet: 140675:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3287.862452] LNetError: 140675:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3287.873697] LNet: Removed LNI 192.168.204.54@tcp [ 3288.146103] Key type .llcrypt unregistered [ 3288.147183] Key type ._llcrypt unregistered [ 3301.644663] Key type ._llcrypt registered [ 3301.646334] Key type .llcrypt registered [ 3301.832708] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3301.837929] alg: No test for adler32 (adler32-zlib) [ 3302.695781] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3302.779383] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 3304.360128] Key type lgssc registered [ 3304.725799] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3329.209634] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3330.303805] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3337.406626] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3338.583630] Lustre: Mounted lustre-client [ 3338.692438] Lustre: Remounted lustre-client read-only [ 3339.044766] LustreError: 144425:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907358e91000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3339.050620] LustreError: 144425:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3339.073129] Lustre: Unmounted lustre-client [ 3356.211040] Key type lgssc unregistered [ 3356.323547] LNet: 144828:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3356.325765] LNetError: 144828:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3356.333697] LNet: Removed LNI 192.168.204.54@tcp [ 3356.602113] Key type .llcrypt unregistered [ 3356.603808] Key type ._llcrypt unregistered [ 3361.610709] Key type ._llcrypt registered [ 3361.611704] Key type .llcrypt registered [ 3362.047115] Lustre: DEBUG MARKER: SKIP: conf-sanity test_106 skipping SLOW test 106 [ 3362.558523] Lustre: DEBUG MARKER: == conf-sanity test 107: Unknown config param should not fail target mounting ========================================================== 20:02:04 (1760140924) [ 3363.296525] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3363.344579] alg: No test for adler32 (adler32-zlib) [ 3364.196367] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3364.280037] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 3365.864136] Key type lgssc registered [ 3366.208105] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3382.818173] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3384.045544] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3390.061622] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3407.505500] Key type lgssc unregistered [ 3407.619380] LNet: 148356:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3407.621302] LNetError: 148356:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3407.628393] LNet: Removed LNI 192.168.204.54@tcp [ 3407.873704] Key type .llcrypt unregistered [ 3407.874665] Key type ._llcrypt unregistered [ 3411.319298] Key type ._llcrypt registered [ 3411.320934] Key type .llcrypt registered [ 3411.561231] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3411.570436] alg: No test for adler32 (adler32-zlib) [ 3412.438286] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3412.534996] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 3414.136157] Key type lgssc registered [ 3414.542360] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3475.090511] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3481.060782] Key type lgssc unregistered [ 3481.219531] LNet: 150303:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3481.222278] LNetError: 150303:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3481.230501] LNet: Removed LNI 192.168.204.54@tcp [ 3481.546504] Key type .llcrypt unregistered [ 3481.547694] Key type ._llcrypt unregistered [ 3486.838897] Key type ._llcrypt registered [ 3486.839910] Key type .llcrypt registered [ 3487.306714] Lustre: DEBUG MARKER: == conf-sanity test 108a: migrate from ldiskfs to ZFS ==== 20:04:09 (1760141049) [ 3487.824190] Lustre: DEBUG MARKER: SKIP: conf-sanity test_108a zfs only test [ 3488.361154] Lustre: DEBUG MARKER: == conf-sanity test 108b: migrate from ZFS to ldiskfs ==== 20:04:10 (1760141050) [ 3492.198469] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3492.221065] alg: No test for adler32 (adler32-zlib) [ 3493.082945] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3493.175667] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 3494.768167] Key type lgssc registered [ 3495.209118] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3527.640646] Lustre: Mounted lustre-client [ 3527.780967] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3527.785318] LustreError: 152869:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff90734570e800: inode [0x200000bd1:0x2:0x0] mdc close failed: rc = -108 [ 3527.794318] Lustre: 151682:0:(llite_lib.c:4240:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.154@tcp:/lustre/fid: [0x200000bd1:0x2:0x0]/ may get corrupted (rc -108) [ 3527.800692] Lustre: 151683:0:(llite_lib.c:4240:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.154@tcp:/lustre/fid: [0x240000402:0x3:0x0]/ may get corrupted (rc -108) [ 3538.086992] LustreError: 152869:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 3538.101122] Lustre: Unmounted lustre-client [ 3567.075704] Lustre: DEBUG MARKER: == conf-sanity test 109a: test lctl clear_conf fsname ==== 20:05:29 (1760141129) [ 3600.599623] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3601.779510] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3609.026769] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3609.210348] Lustre: Mounted lustre-client [ 3669.906335] LustreError: 157390:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907346af5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3669.912179] LustreError: 157390:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3669.914038] LustreError: 157390:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 3669.934124] Lustre: Unmounted lustre-client [ 3710.109285] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3711.219604] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3717.150558] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3722.739528] Lustre: Mounted lustre-client [ 3739.418854] LustreError: 159274:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907348d6b000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3739.424099] LustreError: 159274:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3739.427253] LustreError: 159274:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3739.448895] Lustre: Unmounted lustre-client [ 3764.645507] Key type lgssc unregistered [ 3764.763462] LNet: 159676:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3764.765471] LNetError: 159676:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3764.771508] LNet: Removed LNI 192.168.204.54@tcp [ 3765.013358] Key type .llcrypt unregistered [ 3765.014402] Key type ._llcrypt unregistered [ 3770.125528] Key type ._llcrypt registered [ 3770.126537] Key type .llcrypt registered [ 3770.575402] Lustre: DEBUG MARKER: == conf-sanity test 109b: test lctl clear_conf one config ========================================================== 20:08:52 (1760141332) [ 3779.668903] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3779.690343] alg: No test for adler32 (adler32-zlib) [ 3780.543376] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3780.626784] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 3782.208112] Key type lgssc registered [ 3782.608293] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3812.413156] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3813.693542] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3820.724091] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3827.161318] Lustre: Mounted lustre-client [ 3872.031132] LustreError: 164505:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff9073441ce000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3872.036169] LustreError: 164505:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3872.053398] Lustre: Unmounted lustre-client [ 3903.959476] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3905.063994] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3910.806772] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3926.515085] Lustre: Mounted lustre-client [ 3946.541374] LustreError: 166391:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff90735815b800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3946.547820] LustreError: 166391:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3946.549483] LustreError: 166391:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3946.568077] Lustre: Unmounted lustre-client [ 3963.580686] Key type lgssc unregistered [ 3963.698708] LNet: 166792:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3963.701148] LNetError: 166792:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3963.710240] LNet: Removed LNI 192.168.204.54@tcp [ 3963.948171] Key type .llcrypt unregistered [ 3963.949113] Key type ._llcrypt unregistered [ 3968.699827] Key type ._llcrypt registered [ 3968.700702] Key type .llcrypt registered [ 3969.106585] Lustre: DEBUG MARKER: == conf-sanity test 110: Adding large_dir with 3-level htree ========================================================== 20:12:11 (1760141531) [ 3973.196249] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3973.226387] alg: No test for adler32 (adler32-zlib) [ 3974.084840] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 3974.177991] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 3975.776106] Key type lgssc registered [ 3976.221275] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4006.032780] Lustre: Mounted lustre-client [ 4007.581449] Lustre: Mounted lustre-client [ 4193.953812] LustreError: 170729:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907358150000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4193.958390] LustreError: 170729:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 4193.979134] Lustre: Unmounted lustre-client [ 4254.589250] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4256.273754] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4266.330698] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4297.437479] Lustre: DEBUG MARKER: SKIP: conf-sanity test_111 skipping SLOW test 111 [ 4298.347599] Lustre: DEBUG MARKER: == conf-sanity test 112a: mount OST with no_create option ========================================================== 20:17:40 (1760141860) [ 4311.388189] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4313.196303] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4321.864581] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4330.420605] Lustre: Mounted lustre-client [ 4333.003601] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0000-osc-ffff907345471800.ost_server_uuid 50 [ 4333.660358] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-ffff907345471800.ost_server_uuid in FULL state after 0 sec [ 4335.028940] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff907345471800.ost_server_uuid 50 [ 4335.526271] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff907345471800.ost_server_uuid in FULL state after 0 sec [ 4350.950886] Lustre: lustre-OST0001-osc-ffff907345471800: Connection to lustre-OST0001 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4354.874965] LustreError: 177585:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907345471800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4354.878258] LustreError: 177585:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 4354.880865] LustreError: 177585:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4354.882532] LustreError: 177585:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 4354.902419] Lustre: Unmounted lustre-client [ 4354.903441] Lustre: Skipped 1 previous similar message [ 4373.147693] Key type lgssc unregistered [ 4373.290842] LNet: 177986:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4373.294718] LNetError: 177986:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4373.309342] LNet: Removed LNI 192.168.204.54@tcp [ 4373.664215] Key type .llcrypt unregistered [ 4373.666380] Key type ._llcrypt unregistered [ 4379.895713] Key type ._llcrypt registered [ 4379.896737] Key type .llcrypt registered [ 4380.353076] Lustre: DEBUG MARKER: == conf-sanity test 112b: mount MDT with no_create option ========================================================== 20:19:02 (1760141942) [ 4381.397546] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4381.413088] alg: No test for adler32 (adler32-zlib) [ 4382.294370] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4382.414226] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 4384.008182] Key type lgssc registered [ 4384.543996] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4399.946309] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4414.836733] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4423.616972] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4424.901793] Lustre: Mounted lustre-client [ 4514.977384] LustreError: 181385:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907348d87800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4514.983372] LustreError: 181385:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4515.007048] Lustre: Unmounted lustre-client [ 4532.833422] Key type lgssc unregistered [ 4532.956554] LNet: 181787:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4532.958687] LNetError: 181787:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4532.966494] LNet: Removed LNI 192.168.204.54@tcp [ 4533.242924] Key type .llcrypt unregistered [ 4533.243955] Key type ._llcrypt unregistered [ 4539.657045] Key type ._llcrypt registered [ 4539.658160] Key type .llcrypt registered [ 4540.266492] Lustre: DEBUG MARKER: == conf-sanity test 113: Shadow mountpoint correctly report ro/rw for mounts ========================================================== 20:21:42 (1760142102) [ 4550.965443] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4551.001128] alg: No test for adler32 (adler32-zlib) [ 4551.867361] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4551.974758] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 4553.584200] Key type lgssc registered [ 4554.282674] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4591.609773] Lustre: Mounted lustre-client [ 4594.212492] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 4609.790213] LustreError: 185732:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff90734456e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4609.795745] LustreError: 185732:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4609.816985] Lustre: Unmounted lustre-client [ 4677.102984] Lustre: Mounted lustre-client [ 4679.361227] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 4685.719181] LustreError: 187969:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907347d1f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4685.722259] LustreError: 187969:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 4685.726523] LustreError: 187969:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4685.728111] LustreError: 187969:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 4685.753133] Lustre: Unmounted lustre-client [ 4717.914860] Lustre: DEBUG MARKER: SKIP: conf-sanity test_114 skipping SLOW test 114 [ 4718.382650] Lustre: DEBUG MARKER: SKIP: conf-sanity test_115 skipping excluded test 115 [ 4718.888137] Lustre: DEBUG MARKER: == conf-sanity test 116: big size MDT support ============ 20:24:41 (1760142281) [ 4784.867815] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4786.007222] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4793.099115] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4815.797278] Lustre: DEBUG MARKER: == conf-sanity test 117: lctl get_param return errors properly ========================================================== 20:26:18 (1760142378) [ 4824.630969] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4825.763847] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4831.202712] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4831.372930] Lustre: Mounted lustre-client [ 4837.697924] LustreError: 195075:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907350609000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4837.701122] LustreError: 195075:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 4837.705771] LustreError: 195075:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4837.707326] LustreError: 195075:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 4837.728154] Lustre: Unmounted lustre-client [ 4855.006193] Key type lgssc unregistered [ 4855.162679] LNet: 195476:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4855.166331] LNetError: 195476:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4855.178755] LNet: Removed LNI 192.168.204.54@tcp [ 4855.558175] Key type .llcrypt unregistered [ 4855.559749] Key type ._llcrypt unregistered [ 4861.725880] Key type ._llcrypt registered [ 4861.727196] Key type .llcrypt registered [ 4862.383936] Lustre: DEBUG MARKER: == conf-sanity test 119: writeconf on slave mdt shouldn't duplicate mdc/osp and crash ========================================================== 20:27:04 (1760142424) [ 4864.131957] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4864.169161] alg: No test for adler32 (adler32-zlib) [ 4865.024508] Lustre: Lustre: Build Version: 2.16.58_105_gc3ac3ca [ 4865.110608] LNet: Added LNI 192.168.204.54@tcp [8/256/0/180] [ 4866.696109] Key type lgssc registered [ 4867.073634] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4883.550057] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4884.694209] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4890.633692] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4891.814348] Lustre: Mounted lustre-client [ 4897.251896] Lustre: lustre-MDT0001-mdc-ffff907358f17000: Connection to lustre-MDT0001 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4907.950122] LustreError: 198845:0:(obd_config.c:1997:class_config_llog_handler()) MGC192.168.204.154@tcp: cfg command failed: rc = -17 [ 4907.955124] Lustre: cmd=cf001 0:lustre-MDT0001-mdc 1:mdc 2:lustre-clilmv_UUID [ 4907.955124] [ 4907.959186] LustreError: 198481:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 5209.573899] Lustre: lustre-MDT0001-mdc-ffff907358f17000: Connection to lustre-MDT0001 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5225.975525] LustreError: 200940:0:(obd_config.c:689:class_setup()) Device 4 already setup (type mdc) [ 5225.980090] LustreError: 200940:0:(obd_config.c:1997:class_config_llog_handler()) MGC192.168.204.154@tcp: cfg command failed: rc = -17 [ 5225.986049] Lustre: cmd=cf003 0:lustre-MDT0001-mdc 1:lustre-MDT0001_UUID 2:192.168.204.154@tcp [ 5225.986049] [ 5225.991398] LustreError: 198481:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 5527.012108] Lustre: lustre-MDT0001-mdc-ffff907358f17000: Connection to lustre-MDT0001 (at 192.168.204.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5553.141902] LustreError: 202956:0:(obd_config.c:1997:class_config_llog_handler()) MGC192.168.204.154@tcp: cfg command failed: rc = -17 [ 5553.148214] Lustre: cmd=cf014 0:lustre-clilmv 1:lustre-MDT0001_UUID 2:1 3:1 4:lustre-MDT0001-mdc_UUID [ 5553.148214] [ 5553.154919] LustreError: 198481:0:(mgc_request.c:614:do_requeue()) failed processing log: -17 [ 5848.791812] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5859.049026] LustreError: 204902:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5859.062129] Lustre: Unmounted lustre-client [ 5896.086986] Lustre: DEBUG MARKER: == conf-sanity test 120: cross-target rename should not create bad symlinks ========================================================== 20:44:18 (1760143458) [ 5907.988822] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5909.103957] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5915.730571] Lustre: DEBUG MARKER: oleg454-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5915.881227] Lustre: Mounted lustre-client [ 5917.584109] LustreError: 208828:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff907348d8d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5917.589443] LustreError: 208828:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5917.591094] LustreError: 208828:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5917.610644] Lustre: Unmounted lustre-client [ 5959.161441] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 5828 sec ========== 20:45:21 (1760143521) [ 5959.974300] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 20:45:22 (1760143522) === [ 5961.609259] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 20:45:23 (1760143523) === [ 5976.915590] Key type lgssc unregistered [ 5977.081430] LNet: 212665:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5977.086405] LNetError: 212665:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5977.097768] LNet: Removed LNI 192.168.204.54@tcp [ 5977.543210] Key type .llcrypt unregistered [ 5977.545270] Key type ._llcrypt unregistered