[ 0.000000] Linux version 4.18.0rh8.10-debug (green@maintenance) (gcc version 8.5.0 20210514 (Red Hat 8.5.0-26) (GCC)) #2 SMP Mon Jul 14 01:24:22 EDT 2025 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] signal: max sigframe size: 1776 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffd9fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffda000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000146dfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.17.0-8.fc42 06/10/2025 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 432024137 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2421 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE22BD 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 00227D (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2331 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE23C1 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE23F9 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe22bd-0xbffe2330] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22bc] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2331-0xbffe23c0] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe23c1-0xbffe23f8] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe23f9-0xbffe2420] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 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.001010] APIC: Switch to symmetric I/O mode setup [ 0.002279] x2apic enabled [ 0.003005] Switched APIC routing to physical x2apic. [ 0.004010] kvm-guest: setup PV IPIs [ 0.007582] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008019] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009008] pid_max: default: 32768 minimum: 301 [ 0.010144] LSM: Security Framework initializing [ 0.011049] Yama: becoming mindful. [ 0.012030] SELinux: Initializing. [ 0.014026] *** VALIDATE selinux *** [ 0.019480] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.023219] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.024120] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.025090] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026096] *** VALIDATE tmpfs *** [ 0.027375] *** VALIDATE proc *** [ 0.029029] *** VALIDATE cgroup *** [ 0.029868] *** VALIDATE cgroup2 *** [ 0.030207] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.031146] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.032005] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.033023] Spectre V2 : User space: Vulnerable [ 0.034006] Speculative Store Bypass: Vulnerable [ 0.037157] debug: unmapping init [mem 0xffffffffa7459000-0xffffffffa7460fff] [ 0.039213] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.040541] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.041014] ... version: 2 [ 0.042009] ... bit width: 48 [ 0.043007] ... generic registers: 4 [ 0.043713] ... value mask: 0000ffffffffffff [ 0.044007] ... max period: 00007fffffffffff [ 0.045009] ... fixed-purpose events: 3 [ 0.045965] ... event mask: 000000070000000f [ 0.046223] rcu: Hierarchical SRCU implementation. [ 0.048356] smp: Bringing up secondary CPUs ... [ 0.049527] x86: Booting SMP configuration: [ 0.050012] .... node #0, CPUs: #1 #2 #3 [ 0.053151] smp: Brought up 1 node, 4 CPUs [ 0.054929] smpboot: Max logical packages: 1 [ 0.055011] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.097023] node 0 deferred pages initialised in 40ms [ 0.099476] devtmpfs: initialized [ 0.100240] x86/mm: Memory block size: 128MB [ 0.103312] gcov: version magic: 0x41383552 [ 0.104541] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.107116] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.109274] pinctrl core: initialized pinctrl subsystem [ 0.110109] [ 0.110478] ************************************************************* [ 0.111000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.111000] ** ** [ 0.112013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.113006] ** ** [ 0.115007] ** This means that this kernel is built to expose internal ** [ 0.117010] ** IOMMU data structures, which may compromise security on ** [ 0.119010] ** your system. ** [ 0.122014] ** ** [ 0.124007] ** If you see this message and you are not debugging the ** [ 0.125008] ** kernel, report this immediately to your vendor! ** [ 0.127014] ** ** [ 0.128007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.129008] ************************************************************* [ 0.131530] NET: Registered protocol family 16 [ 0.132324] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.134030] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.136056] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.138507] cpuidle: using governor menu [ 0.139758] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.142297] PCI: Using configuration type 1 for base access [ 0.144098] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.152252] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.153010] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.155041] cryptd: max_cpu_qlen set to 1000 [ 0.158255] ACPI: Added _OSI(Module Device) [ 0.160015] ACPI: Added _OSI(Processor Device) [ 0.164016] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.168017] ACPI: Added _OSI(Processor Aggregator Device) [ 0.173238] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.178368] ACPI: Interpreter enabled [ 0.180065] ACPI: PM: (supports S0 S3 S4 S5) [ 0.181010] ACPI: Using IOAPIC for interrupt routing [ 0.182113] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.185378] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.195982] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.197032] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.200016] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.203075] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.206953] acpiphp: Slot [2] registered [ 0.208055] acpiphp: Slot [5] registered [ 0.208854] acpiphp: Slot [6] registered [ 0.209052] acpiphp: Slot [3] registered [ 0.210051] acpiphp: Slot [4] registered [ 0.212076] acpiphp: Slot [7] registered [ 0.213060] acpiphp: Slot [8] registered [ 0.215103] acpiphp: Slot [9] registered [ 0.217216] acpiphp: Slot [10] registered [ 0.218103] acpiphp: Slot [11] registered [ 0.220066] acpiphp: Slot [12] registered [ 0.221063] acpiphp: Slot [13] registered [ 0.223109] acpiphp: Slot [14] registered [ 0.225091] acpiphp: Slot [15] registered [ 0.226065] acpiphp: Slot [16] registered [ 0.226934] acpiphp: Slot [17] registered [ 0.228060] acpiphp: Slot [18] registered [ 0.228950] acpiphp: Slot [19] registered [ 0.230056] acpiphp: Slot [20] registered [ 0.231067] acpiphp: Slot [21] registered [ 0.232085] acpiphp: Slot [22] registered [ 0.234077] acpiphp: Slot [23] registered [ 0.235092] acpiphp: Slot [24] registered [ 0.236072] acpiphp: Slot [25] registered [ 0.237089] acpiphp: Slot [26] registered [ 0.238076] acpiphp: Slot [27] registered [ 0.240074] acpiphp: Slot [28] registered [ 0.241076] acpiphp: Slot [29] registered [ 0.243080] acpiphp: Slot [30] registered [ 0.244156] acpiphp: Slot [31] registered [ 0.246079] PCI host bridge to bus 0000:00 [ 0.247016] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.250029] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.253023] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.257026] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.260022] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.262021] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.264319] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.269129] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.272650] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.279639] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.284012] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.287015] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.289014] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.291015] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.294620] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.296843] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.300045] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.302678] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.307012] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.319019] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.321976] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.327622] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.334088] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.339012] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.357022] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.368541] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.373011] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.378011] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.400014] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.416237] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.417265] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.419299] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.421200] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.422147] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.426273] iommu: Default domain type: Passthrough [ 0.428423] SCSI subsystem initialized [ 0.430125] ACPI: bus type USB registered [ 0.431077] usbcore: registered new interface driver usbfs [ 0.433043] usbcore: registered new interface driver hub [ 0.435078] usbcore: registered new device driver usb [ 0.437152] pps_core: LinuxPPS API ver. 1 registered [ 0.439011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.441046] PTP clock support registered [ 0.443123] EDAC MC: Ver: 3.0.0 [ 0.446278] PCI: Using ACPI for IRQ routing [ 0.449647] NetLabel: Initializing [ 0.452015] NetLabel: domain hash size = 128 [ 0.455011] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.458114] NetLabel: unlabeled traffic allowed by default [ 0.461271] vgaarb: loaded [ 0.463473] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.466013] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.473484] clocksource: Switched to clocksource kvm-clock [ 0.605851] VFS: Disk quotas dquot_6.6.0 [ 0.607397] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.609925] *** VALIDATE ramfs *** [ 0.611380] *** VALIDATE hugetlbfs *** [ 0.613238] pnp: PnP ACPI init [ 0.615577] pnp: PnP ACPI: found 6 devices [ 0.632434] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.635695] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.638112] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.640479] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.642927] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.645512] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.650507] NET: Registered protocol family 2 [ 0.660215] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.668763] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.671455] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.675946] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.678913] TCP: Hash tables configured (established 65536 bind 65536) [ 0.681165] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.684984] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.691751] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.697634] NET: Registered protocol family 1 [ 0.702651] RPC: Registered named UNIX socket transport module. [ 0.708572] RPC: Registered udp transport module. [ 0.710813] RPC: Registered tcp transport module. [ 0.712582] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.714622] NET: Registered protocol family 44 [ 0.716363] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.718240] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.720080] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.721966] PCI: CLS 0 bytes, default 64 [ 0.724190] Unpacking initramfs... [ 2.323115] debug: unmapping init [mem 0xffffa0203cc64000-0xffffa0203ffcffff] [ 2.326988] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.329098] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.331733] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.942544] Initialise system trusted keyrings [ 2.944272] Key type blacklist registered [ 2.946291] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.955767] zbud: loaded [ 2.958890] *** VALIDATE nfs *** [ 2.960275] *** VALIDATE nfs4 *** [ 2.961571] pstore: using deflate compression [ 2.965814] Platform Keyring initialized [ 3.082493] NET: Registered protocol family 38 [ 3.083985] Key type asymmetric registered [ 3.085170] Asymmetric key parser 'x509' registered [ 3.086428] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.089822] io scheduler mq-deadline registered [ 3.091794] io scheduler kyber registered [ 3.093521] io scheduler bfq registered [ 3.095515] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.098184] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.101292] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.104320] ACPI: Power Button [PWRF] [ 3.110315] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.116665] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.137529] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.167348] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.193720] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.197365] Non-volatile memory driver v1.3 [ 3.198415] Linux agpgart interface v0.103 [ 3.222467] virtio_blk virtio1: [vda] 134032 512-byte logical blocks (68.6 MB/65.4 MiB) [ 3.225280] vda: detected capacity change from 0 to 68624384 [ 3.240300] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.242933] vdb: detected capacity change from 0 to 1073741824 [ 3.248564] libphy: Fixed MDIO Bus: probed [ 3.254537] usbcore: registered new interface driver usbserial_generic [ 3.256224] usbserial: USB Serial support registered for generic [ 3.257873] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.260801] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.262460] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.264728] mousedev: PS/2 mouse device common for all mice [ 3.266882] rtc_cmos 00:05: RTC can wake from S4 [ 3.268767] rtc_cmos 00:05: registered as rtc0 [ 3.270850] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.272748] intel_pstate: CPU model not supported [ 3.273873] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.282857] hid: raw HID events driver (C) Jiri Kosina [ 3.283966] usbcore: registered new interface driver usbhid [ 3.291298] usbhid: USB HID core driver [ 3.292712] drop_monitor: Initializing network drop monitor service [ 3.295383] Initializing XFRM netlink socket [ 3.297965] NET: Registered protocol family 10 [ 3.299813] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.304645] Segment Routing with IPv6 [ 3.304686] NET: Registered protocol family 17 [ 3.304879] mpls_gso: MPLS GSO support [ 3.317772] RAS: Correctable Errors collector initialized. [ 3.320599] AVX version of gcm_enc/dec engaged. [ 3.322523] AES CTR mode by8 optimization enabled [ 3.323901] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.414109] sched_clock: Marking stable (3414062917, 0)->(4236068636, -822005719) [ 3.418746] registered taskstats version 1 [ 3.421212] Loading compiled-in X.509 certificates [ 3.423848] zswap: loaded using pool lzo/zbud [ 3.447181] Key type big_key registered [ 3.464095] Key type encrypted registered [ 3.466233] ima: No TPM chip found, activating TPM-bypass! [ 3.468770] ima: Allocated hash algorithm: sha1 [ 3.471892] ima: No architecture policies found [ 3.474518] evm: Initialising EVM extended attributes: [ 3.477122] evm: security.selinux [ 3.477896] evm: security.ima [ 3.479724] evm: security.capability [ 3.480669] evm: HMAC attrs: 0x1 [ 3.482839] rtc_cmos 00:05: setting system clock to 2026-01-22 09:10:08 UTC (1769073008) [ 3.491470] debug: unmapping init [mem 0xffffffffa8403000-0xffffffffa85fffff] [ 3.495133] debug: unmapping init [mem 0xffffffffa7182000-0xffffffffa7458fff] [ 3.504046] Write protecting the kernel read-only data: 28672k [ 3.506083] debug: unmapping init [mem 0xffffffffa5803000-0xffffffffa59fffff] [ 3.507562] debug: unmapping init [mem 0xffffffffa6114000-0xffffffffa61fffff] [ 3.539334] 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.612882] systemd[1]: Detected virtualization kvm. [ 3.616111] systemd[1]: Detected architecture x86-64. [ 3.618901] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.696734] systemd[1]: No hostname configured. [ 3.702107] systemd[1]: Set hostname to . [ 3.705870] random: systemd: uninitialized urandom read (16 bytes read) [ 3.710769] systemd[1]: Initializing machine ID from random generator. [ 3.859859] random: ln: uninitialized urandom read (6 bytes read) [ 4.279406] random: systemd: uninitialized urandom read (16 bytes read) [ 4.288261] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 4.303930] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 4.320725] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Swap. [ OK ] Reached target Slices. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on udev Kernel Socket. Starting Apply Kernel Variables... [ OK ] Reached target Sockets. Starting Journal Service... Starting Setup Virtual Console... [ OK ] Reached target Timers. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ 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.335224] device-mapper: uevent: version 1.0.3 [ 5.337480] 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... [ 7.418147] virtio_net virtio0 ens2: renamed from eth0 [ OK [0[ 7.461599] random: fast init done m] Started udev Coldplug all Devices. [ OK ] Mounted Kernel Configuration File System. [ 8.748988] scsi host0: ata_piix [ 8.761646] scsi host1: ata_piix [ 8.764182] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 8.767317] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 15.031038] random: crng init done [ 15.037735] random: 7 urandom warning(s) missed due to ratelimiting [ 17.495625] dracut-initqueue[570]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 20.184045] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ 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 Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 22.211443] printk: systemd: 26 output lines suppressed due to ratelimiting [ 22.702950] SELinux: Disabled at runtime. [ 22.772369] 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) [ 22.783843] systemd[1]: Detected virtualization kvm. [ 22.788027] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 24.007073] systemd[1]: initrd-switch-root.service: Succeeded. [ 24.010739] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 24.026621] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 24.031382] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 24.036307] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 24.054563] systemd[1]: Starting Journal Service... Starting Journal Service... [ 24.061410] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Activating swap /dev/disk/by-label/SWAP... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ 24.107724] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Created slice User and Session Slice. [ OK ] Stopped target Switch Root. [ OK ] Reached target Slices. [ OK ] Reached target Local Encrypted Volumes. [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... Mounting POSIX Message Queue File System... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Kernel Socket. Starting Remount Root and Kernel File Systems... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Apply Kernel Variables... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting Kernel Debug File System... [ OK ] Stopped target Initrd File Systems. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-getty.slice. [ OK ] Stopped target Initrd Root File System. Mounting Huge Pages File System... [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Listening on Process Core Dump Socket. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Reached target Swap. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started udev Coldplug all Devices. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 25.393759] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 26.547836] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 26.766578] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 28.179330] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 28.280042] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (7s / no limit)[ 31.509285] Key type dns_resolver registered [** ] A start job is running for Configur…-only root support (7s / no limit)[ 31.979653] NFS: Registering the id_resolver key type [ 31.982310] Key type id_resolver registered [ 31.983909] Key type id_legacy registered [*** ] A start job is running for Configur…-only root support (8s / no limit) [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started RPC Bind. [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. [ OK ] Started D-Bus System Message Bus. Starting Login Service... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Started OpenSSH server 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 Login Service. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ 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. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg355-client login: [ 85.342664] libcfs: loading out-of-tree module taints kernel. [ 85.632450] Key type ._llcrypt registered [ 85.668196] Key type .llcrypt registered [ 86.013551] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 86.022925] alg: No test for adler32 (adler32-zlib) [ 87.250056] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 87.727097] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 89.408355] Key type lgssc registered [ 90.797935] Lustre: Echo OBD driver; http://www.lustre.org/ [ 197.233336] Lustre: Mounted lustre-client [ 200.786932] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 214.468878] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing check_logdir /tmp/testlogs/ [ 217.456674] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing yml_node [ 219.937925] Lustre: DEBUG MARKER: Client: 2.17.50.4 [ 221.315277] Lustre: DEBUG MARKER: MDS: 2.17.50.4 [ 222.692602] Lustre: lustre-OST0000-osc-ffffa020854ba800: disconnect after 23s idle [ 222.745809] Lustre: DEBUG MARKER: OSS: 2.17.50.4 [ 223.624651] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Jan 22 04:13:47 EST 2026 [ 234.781761] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 235.641964] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 236.998343] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 247.275177] LustreError: 8966:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 247.304814] Lustre: Unmounted lustre-client [ 335.367356] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 339.851857] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 361.664138] hrtimer: interrupt took 5143255 ns [ 368.579054] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 416.172525] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 04:16:59 (1769073419) [ 418.405691] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 419.916260] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 04:17:03 (1769073423) [ 451.703847] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 455.231406] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 474.150699] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 474.873824] Lustre: Mounted lustre-client [ 480.293257] LustreError: 14417:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02085990800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 480.366586] LustreError: 14417:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 480.378352] LustreError: 14417:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 480.436225] Lustre: Unmounted lustre-client [ 511.084502] Key type lgssc unregistered [ 511.400669] LNet: 14825:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 511.407886] LNetError: 14825:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 511.426467] LNet: Removed LNI 192.168.203.55@tcp [ 512.319158] Key type .llcrypt unregistered [ 512.324569] Key type ._llcrypt unregistered [ 531.094603] Key type ._llcrypt registered [ 531.096504] Key type .llcrypt registered [ 532.221853] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 04:18:55 (1769073535) [ 533.841087] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 533.889813] alg: No test for adler32 (adler32-zlib) [ 535.046479] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 535.302948] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 536.981111] Key type lgssc registered [ 538.324516] Lustre: Echo OBD driver; http://www.lustre.org/ [ 614.284206] Lustre: Mounted lustre-client [ 706.714572] LustreError: 18144:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02098e3c000: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 706.723791] LustreError: 18144:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 706.770395] Lustre: Unmounted lustre-client [ 735.354264] Key type lgssc unregistered [ 735.659887] LNet: 18607:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 735.668289] LNetError: 18607:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 735.694421] LNet: Removed LNI 192.168.203.55@tcp [ 736.479922] Key type .llcrypt unregistered [ 736.481692] Key type ._llcrypt unregistered [ 746.542848] Key type ._llcrypt registered [ 746.553235] Key type .llcrypt registered [ 747.813910] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 04:22:31 (1769073751) [ 750.001883] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 750.026228] alg: No test for adler32 (adler32-zlib) [ 751.139971] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 751.426895] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 753.080169] Key type lgssc registered [ 754.115574] Lustre: Echo OBD driver; http://www.lustre.org/ [ 804.874528] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 809.885517] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 831.624952] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 834.503042] Lustre: Mounted lustre-client [ 846.198682] LustreError: 21719:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02098e22800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 846.223600] LustreError: 21719:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 846.291815] Lustre: Unmounted lustre-client [ 870.511158] Key type lgssc unregistered [ 870.737149] LNet: 22122:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 870.741449] LNetError: 22122:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 870.754871] LNet: Removed LNI 192.168.203.55@tcp [ 871.505129] Key type .llcrypt unregistered [ 871.511178] Key type ._llcrypt unregistered [ 882.575621] Key type ._llcrypt registered [ 882.580454] Key type .llcrypt registered [ 883.929531] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 04:24:47 (1769073887) [ 886.637342] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 886.710564] alg: No test for adler32 (adler32-zlib) [ 887.974211] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 888.250733] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 889.928764] Key type lgssc registered [ 891.389433] Lustre: Echo OBD driver; http://www.lustre.org/ [ 943.753390] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 948.925681] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 969.708301] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 972.488729] Lustre: Mounted lustre-client [ 978.719494] LustreError: 24827:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02098e23000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 978.747182] LustreError: 24827:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 978.782762] Lustre: Unmounted lustre-client [ 1015.866331] Key type lgssc unregistered [ 1016.133205] LNet: 25231:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1016.155358] LNetError: 25231:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1016.170601] LNet: Removed LNI 192.168.203.55@tcp [ 1016.827444] Key type .llcrypt unregistered [ 1016.832757] Key type ._llcrypt unregistered [ 1032.622371] Key type ._llcrypt registered [ 1032.625677] Key type .llcrypt registered [ 1033.740516] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 04:27:17 (1769074037) [ 1037.037327] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1037.296955] alg: No test for adler32 (adler32-zlib) [ 1038.647572] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 1039.001994] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 1040.784229] Key type lgssc registered [ 1042.464582] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1097.561769] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1102.113185] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1123.320298] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1126.160601] Lustre: Mounted lustre-client [ 1131.502663] Lustre: lustre-MDT0000-mdc-ffffa02082e06000: Connection to lustre-MDT0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1146.861146] Lustre: lustre-MDT0001-mdc-ffffa02082e06000: Connection to lustre-MDT0001 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1150.546304] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1157.089737] Lustre: 26186:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769074146/real 1769074146] req@0000000057771204 x1855008584767488/t0(0) o400->MGC192.168.203.155@tcp@192.168.203.155@tcp:26/25 lens 224/224 e 0 to 1 dl 1769074162 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1157.137572] LustreError: MGC192.168.203.155@tcp: Connection to MGS (at 192.168.203.155@tcp) was lost; in progress operations using this service will fail [ 1160.822361] LustreError: 28409:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1160.876597] Lustre: Unmounted lustre-client [ 1181.336424] Key type lgssc unregistered [ 1181.725539] LNet: 28803:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1181.737667] LNetError: 28803:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1181.778582] LNet: Removed LNI 192.168.203.55@tcp [ 1182.703633] Key type .llcrypt unregistered [ 1182.710804] Key type ._llcrypt unregistered [ 1199.194681] Key type ._llcrypt registered [ 1199.196881] Key type .llcrypt registered [ 1200.463319] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 04:30:04 (1769074204) [ 1202.471423] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1202.640092] alg: No test for adler32 (adler32-zlib) [ 1203.743327] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 1204.023650] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 1205.696346] Key type lgssc registered [ 1207.089614] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1253.753680] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1258.293743] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1276.890707] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1278.512895] Lustre: Mounted lustre-client [ 1283.559751] Lustre: lustre-OST0000-osc-ffffa02083321000: Connection to lustre-OST0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1290.283496] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1300.619787] LustreError: 31929:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1300.677542] Lustre: Unmounted lustre-client [ 1328.558702] Key type lgssc unregistered [ 1328.814140] LNet: 32331:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1328.826234] LNetError: 32331:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1328.848048] LNet: Removed LNI 192.168.203.55@tcp [ 1329.599917] Key type .llcrypt unregistered [ 1329.604631] Key type ._llcrypt unregistered [ 1344.893316] Key type ._llcrypt registered [ 1344.896233] Key type .llcrypt registered [ 1346.164779] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 04:32:29 (1769074349) [ 1348.376543] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1348.429026] alg: No test for adler32 (adler32-zlib) [ 1349.413780] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 1349.581188] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 1351.216170] Key type lgssc registered [ 1352.359521] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1400.570938] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1405.135796] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1423.864495] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1426.388682] Lustre: Mounted lustre-client [ 1429.854577] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1433.244399] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1445.468869] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-01-22 4h34m08s [ 1448.128833] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1452.015866] Lustre: lustre-MDT0000-mdc-ffffa0208bb30000: Connection to lustre-MDT0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1458.949310] LustreError: 36037:0:(lmv_obd.c:1435:lmv_statfs()) lustre-MDT0000-mdc-ffffa0208bb30000: can't stat MDS #0: rc = -19 [ 1460.216751] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1469.414707] LustreError: MGC192.168.203.155@tcp: Connection to MGS (at 192.168.203.155@tcp) was lost; in progress operations using this service will fail [ 1469.440424] Lustre: Evicted from MGS (at 192.168.203.155@tcp) after server handle changed from 0xb41a2687de17c4fe to 0xb41a2687de17c7b3 [ 1469.450993] Lustre: MGC192.168.203.155@tcp: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 1470.504853] LustreError: lustre-MDT0000-mdc-ffffa0208bb30000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1470.530517] Lustre: lustre-MDT0000-mdc-ffffa0208bb30000: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 1475.200834] Lustre: DEBUG MARKER: Wait for df (36037) ... [ 1476.818430] Lustre: DEBUG MARKER: done [ 1479.525102] LustreError: 36653:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208bb30000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1479.536529] LustreError: 36653:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1479.572629] Lustre: Unmounted lustre-client [ 1507.324872] Key type lgssc unregistered [ 1507.581932] LNet: 37056:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1507.594145] LNetError: 37056:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1507.621648] LNet: Removed LNI 192.168.203.55@tcp [ 1508.380781] Key type .llcrypt unregistered [ 1508.383924] Key type ._llcrypt unregistered [ 1549.507234] Key type ._llcrypt registered [ 1549.510603] Key type .llcrypt registered [ 1549.974213] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1549.993969] alg: No test for adler32 (adler32-zlib) [ 1551.258441] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 1551.510062] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 1553.156330] Key type lgssc registered [ 1554.340122] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1634.066729] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1637.967510] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1659.430839] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1700.022477] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 04:38:23 (1769074703) [ 1733.768071] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1737.431731] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1755.098639] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1756.788508] Lustre: Mounted lustre-client [ 1761.330428] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-01-22 4h39m24s [ 1762.825271] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1772.164130] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1774.825811] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1795.552146] Lustre: 43941:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769074780/real 1769074780] req@000000003c3141e9 x1855009121638912/t0(0) o101->lustre-MDT0000-mdc-ffffa020898e0800@192.168.203.155@tcp:12/10 lens 576/1152 e 0 to 1 dl 1769074800 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:0 [ 1795.580213] Lustre: lustre-MDT0000-mdc-ffffa020898e0800: Connection to lustre-MDT0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1795.629563] Lustre: lustre-MDT0000-mdc-ffffa020898e0800: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 1816.753674] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1819.587119] Lustre: DEBUG MARKER: done [ 1822.814637] LustreError: 44416:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020898e0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1822.833679] LustreError: 44416:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1822.869262] Lustre: Unmounted lustre-client [ 1848.939985] Key type lgssc unregistered [ 1849.335178] LNet: 44818:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1849.344043] LNetError: 44818:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1849.392243] LNet: Removed LNI 192.168.203.55@tcp [ 1850.116625] Key type .llcrypt unregistered [ 1850.118698] Key type ._llcrypt unregistered [ 1892.420300] Key type ._llcrypt registered [ 1892.422910] Key type .llcrypt registered [ 1892.586384] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1892.599151] alg: No test for adler32 (adler32-zlib) [ 1893.618658] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 1893.809575] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 1895.440194] Key type lgssc registered [ 1896.738223] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1969.555268] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1973.026715] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1998.890623] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2044.236825] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 04:44:07 (1769075047) [ 2046.066687] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2048.252833] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 04:44:11 (1769075051) [ 2069.252836] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 04:44:32 (1769075072) [ 2102.382848] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2106.237066] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2125.197879] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2126.984066] Lustre: Mounted lustre-client [ 2130.635798] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2134.379594] LustreError: 52662:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020875bc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2134.425444] LustreError: 52662:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2134.519290] Lustre: Unmounted lustre-client [ 2150.518838] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2196.168664] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2200.031969] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2200.564174] Lustre: Mounted lustre-client [ 2203.690198] LustreError: 53924:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02083323000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2203.725939] LustreError: 53924:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2203.733609] LustreError: 53924:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2203.818051] Lustre: Unmounted lustre-client [ 2261.077952] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2265.040862] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2265.954739] Lustre: Mounted lustre-client [ 2270.115248] LustreError: 55046:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020898e6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2270.153210] LustreError: 55046:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2270.157572] LustreError: 55046:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2270.243846] Lustre: Unmounted lustre-client [ 2292.061605] Lustre: DEBUG MARKER: files compared the same [ 2304.811041] Key type lgssc unregistered [ 2305.116607] LNet: 55752:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2305.122942] LNetError: 55752:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2305.166649] LNet: Removed LNI 192.168.203.55@tcp [ 2306.067618] Key type .llcrypt unregistered [ 2306.069907] Key type ._llcrypt unregistered [ 2321.258944] Key type ._llcrypt registered [ 2321.265746] Key type .llcrypt registered [ 2322.938679] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 04:48:46 (1769075326) [ 2325.943962] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2326.002101] alg: No test for adler32 (adler32-zlib) [ 2327.043650] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 2327.267962] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 2329.011887] Key type lgssc registered [ 2330.363840] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2374.800832] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2378.646607] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2399.538284] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2402.675441] Lustre: Mounted lustre-client [ 2407.449050] LustreError: 58850:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020873f6000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2407.474531] LustreError: 58850:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2407.525674] Lustre: Unmounted lustre-client [ 2445.011062] Key type lgssc unregistered [ 2445.310212] LNet: 59252:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2445.338414] LNetError: 59252:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2445.360529] LNet: Removed LNI 192.168.203.55@tcp [ 2446.106950] Key type .llcrypt unregistered [ 2446.110170] Key type ._llcrypt unregistered [ 2465.993151] Key type ._llcrypt registered [ 2465.997649] Key type .llcrypt registered [ 2467.874470] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 04:51:10 (1769075470) [ 2470.278230] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2470.297704] alg: No test for adler32 (adler32-zlib) [ 2471.300434] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 2471.488953] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 2473.144536] Key type lgssc registered [ 2474.190320] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2555.205819] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2586.389847] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2589.887479] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2623.938848] Key type lgssc unregistered [ 2624.235143] LNet: 62648:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2624.248857] LNetError: 62648:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2624.275913] LNet: Removed LNI 192.168.203.55@tcp [ 2625.038554] Key type .llcrypt unregistered [ 2625.040423] Key type ._llcrypt unregistered [ 2641.957623] Key type ._llcrypt registered [ 2641.963984] Key type .llcrypt registered [ 2643.713505] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 04:54:06 (1769075646) [ 2647.094988] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2647.182124] alg: No test for adler32 (adler32-zlib) [ 2648.230693] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 2648.413589] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 2650.056302] Key type lgssc registered [ 2651.613582] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2722.879098] Lustre: Mounted lustre-client [ 2730.192573] LustreError: 65146:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020854bd800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2730.208145] LustreError: 65146:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2730.267187] Lustre: Unmounted lustre-client [ 2767.491701] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 04:56:11 (1769075771) [ 2890.254306] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2908.458817] Lustre: Mounted lustre-client [ 2916.834347] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2916.863172] LustreError: 69110:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffffa020898e7000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2916.892296] Lustre: 63633:0:(llite_lib.c:4226:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.155@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2927.156822] LustreError: 69110:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2927.181370] LustreError: 69110:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2927.228171] Lustre: Unmounted lustre-client [ 2979.030287] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 04:59:42 (1769075982) [ 2992.064120] Key type lgssc unregistered [ 2992.330053] LNet: 70325:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2992.336550] LNetError: 70325:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2992.356292] LNet: Removed LNI 192.168.203.55@tcp [ 2993.006917] Key type .llcrypt unregistered [ 2993.012183] Key type ._llcrypt unregistered [ 3008.599736] Key type ._llcrypt registered [ 3008.600908] Key type .llcrypt registered [ 3009.313242] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3009.335569] alg: No test for adler32 (adler32-zlib) [ 3010.569087] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 3010.875712] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 3012.632175] Key type lgssc registered [ 3014.021457] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3068.029615] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3072.179586] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3094.319407] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3096.127078] Lustre: Mounted lustre-client [ 3100.713268] LustreError: 72865:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02089b94800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3100.761646] LustreError: 72865:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3100.828356] Lustre: Unmounted lustre-client [ 3129.171936] Key type lgssc unregistered [ 3129.552576] LNet: 73268:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3129.560559] LNetError: 73268:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3129.611224] LNet: Removed LNI 192.168.203.55@tcp [ 3130.236266] Key type .llcrypt unregistered [ 3130.240292] Key type ._llcrypt unregistered [ 3141.961626] Key type ._llcrypt registered [ 3141.970283] Key type .llcrypt registered [ 3142.540822] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3142.552654] alg: No test for adler32 (adler32-zlib) [ 3143.681266] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 3143.874655] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 3145.520157] Key type lgssc registered [ 3146.609193] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3244.727241] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3247.985974] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3270.314634] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3273.345565] Lustre: Mounted lustre-client [ 3277.159551] LustreError: 76213:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020870a7000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3277.198233] LustreError: 76213:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3277.249038] Lustre: Unmounted lustre-client [ 3315.917060] Key type lgssc unregistered [ 3316.187918] LNet: 76619:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3316.191766] LNetError: 76619:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3316.212406] LNet: Removed LNI 192.168.203.55@tcp [ 3316.980616] Key type .llcrypt unregistered [ 3316.986654] Key type ._llcrypt unregistered [ 3332.336208] Key type ._llcrypt registered [ 3332.338284] Key type .llcrypt registered [ 3333.703057] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 05:05:37 (1769076337) [ 3336.395064] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3336.501412] alg: No test for adler32 (adler32-zlib) [ 3337.824537] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 3338.089068] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 3339.865101] Key type lgssc registered [ 3341.727906] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3394.230792] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3398.786633] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3422.385553] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3424.652288] Lustre: Mounted lustre-client [ 3432.863525] LustreError: 79743:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02087e45800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3432.895038] LustreError: 79743:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3432.969705] Lustre: Unmounted lustre-client [ 3433.553694] Lustre: Mounted lustre-client [ 3438.822371] LustreError: 79824:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020a0353000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3438.840835] LustreError: 79824:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3438.844640] LustreError: 79824:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3438.884343] Lustre: Unmounted lustre-client [ 3469.109080] Key type lgssc unregistered [ 3469.625079] LNet: 80224:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3469.641704] LNetError: 80224:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3469.688029] LNet: Removed LNI 192.168.203.55@tcp [ 3470.775976] Key type .llcrypt unregistered [ 3470.778543] Key type ._llcrypt unregistered [ 3486.712448] Key type ._llcrypt registered [ 3486.714105] Key type .llcrypt registered [ 3487.153569] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3487.167690] alg: No test for adler32 (adler32-zlib) [ 3488.188361] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 3488.383122] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 3490.056382] Key type lgssc registered [ 3491.191158] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3549.059996] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3553.784521] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3575.860653] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3578.771578] Lustre: Mounted lustre-client [ 3586.785347] LustreError: 82767:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208715e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3586.822062] LustreError: 82767:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3586.924638] Lustre: Unmounted lustre-client [ 3615.790631] Key type lgssc unregistered [ 3616.110496] LNet: 83172:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3616.117145] LNetError: 83172:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3617.192657] LNet: Removed LNI 192.168.203.55@tcp [ 3618.178530] Key type .llcrypt unregistered [ 3618.187373] Key type ._llcrypt unregistered [ 3636.445038] Key type ._llcrypt registered [ 3636.448694] Key type .llcrypt registered [ 3638.083951] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 05:10:41 (1769076641) [ 3641.624800] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3641.647903] alg: No test for adler32 (adler32-zlib) [ 3643.032933] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 3643.386527] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 3645.136414] Key type lgssc registered [ 3646.669653] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3704.051840] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3708.525227] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3731.390317] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3733.426588] Lustre: Mounted lustre-client [ 3741.168533] Lustre: lustre: root_squash is set to 0:0 [ 3748.985389] Lustre: lustre: nosquash_nids is cleared [ 3749.052267] Lustre: lustre: root_squash is set to 500:500 [ 3768.887676] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.55@tcp 192.168.0.[2,10]@tcp [ 3779.164097] Lustre: lustre: nosquash_nids set to 192.168.203.55/24@tcp [ 3782.976785] LustreError: 86676:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02087e43800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3783.020213] LustreError: 86676:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3783.094353] Lustre: Unmounted lustre-client [ 3818.381848] Key type lgssc unregistered [ 3818.722805] LNet: 87080:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3818.726824] LNetError: 87080:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3818.743252] LNet: Removed LNI 192.168.203.55@tcp [ 3819.585213] Key type .llcrypt unregistered [ 3819.587692] Key type ._llcrypt unregistered [ 3840.674524] Key type ._llcrypt registered [ 3840.681733] Key type .llcrypt registered [ 3842.522960] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 05:14:05 (1769076845) [ 3845.270943] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3847.419063] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 05:14:10 (1769076850) [ 3850.160882] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3850.202727] alg: No test for adler32 (adler32-zlib) [ 3851.359101] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 3851.587711] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 3853.288180] Key type lgssc registered [ 3855.291707] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3908.148049] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3912.557151] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3934.359864] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3935.917697] Lustre: lustre: root_squash is set to 500:500 [ 3935.980025] Lustre: lustre: nosquash_nids set to 192.168.203.55/24@tcp [ 3937.013447] Lustre: Mounted lustre-client [ 3942.504746] LustreError: 90552:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208b370800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3942.541108] LustreError: 90552:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 3942.600470] Lustre: Unmounted lustre-client [ 3976.297021] Key type lgssc unregistered [ 3976.563969] LNet: 90964:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3976.570039] LNetError: 90964:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3976.584092] LNet: Removed LNI 192.168.203.55@tcp [ 3977.221326] Key type .llcrypt unregistered [ 3977.222950] Key type ._llcrypt unregistered [ 3996.882845] Key type ._llcrypt registered [ 3996.885275] Key type .llcrypt registered [ 3998.034827] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3999.993597] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 05:16:43 (1769077003) [ 4020.190304] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4020.201793] alg: No test for adler32 (adler32-zlib) [ 4021.451529] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 4021.728273] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 4023.448176] Key type lgssc registered [ 4024.738178] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4117.933128] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4122.205563] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4149.668702] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4229.092863] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4233.292422] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4253.938775] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4267.913642] Lustre: Mounted lustre-client [ 4302.639902] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffffa02087539800.ost_server_uuid 50 [ 4304.471594] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffffa02087539800.ost_server_uuid in IDLE state after 0 sec [ 4305.044225] Lustre: Mounted lustre-client [ 4308.556629] LustreError: 97884:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02089b90800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4308.589119] LustreError: 97884:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 4308.661996] Lustre: Unmounted lustre-client [ 4310.855525] LustreError: 97904:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02087539800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4310.867677] LustreError: 97904:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 4310.899720] LustreError: 97904:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4310.905480] LustreError: 97904:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 4310.979533] Lustre: Unmounted lustre-client [ 4365.495188] Key type lgssc unregistered [ 4365.906587] LNet: 98459:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4365.920178] LNetError: 98459:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4365.946196] LNet: Removed LNI 192.168.203.55@tcp [ 4367.209141] Key type .llcrypt unregistered [ 4367.210819] Key type ._llcrypt unregistered [ 4422.578712] Key type ._llcrypt registered [ 4422.603982] Key type .llcrypt registered [ 4423.370684] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 4423.402538] alg: No test for adler32 (adler32-zlib) [ 4424.482778] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 4424.729783] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 4426.451228] Key type lgssc registered [ 4427.954773] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4516.961319] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4520.374127] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4539.992137] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4579.297447] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 05:26:22 (1769077582) [ 4675.474133] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4679.677372] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4705.267289] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4706.957139] Lustre: Mounted lustre-client [ 4728.800156] Lustre: 99250:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769077717/real 1769077717] req@00000000673faa88 x1855012134196352/t0(0) o400->lustre-OST0000-osc-ffffa02088798800@192.168.203.155@tcp:28/4 lens 224/224 e 0 to 1 dl 1769077733 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4728.855663] Lustre: lustre-OST0000-osc-ffffa02088798800: Connection to lustre-OST0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4734.944889] Lustre: 99250:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769077722/real 1769077722] req@000000006d397d1f x1855012134196864/t0(0) o400->lustre-OST0000-osc-ffffa02088798800@192.168.203.155@tcp:28/4 lens 224/224 e 0 to 1 dl 1769077738 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4738.016898] Lustre: 99249:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769077727/real 1769077727] req@000000001a2d6299 x1855012134197376/t0(0) o400->lustre-OST0000-osc-ffffa02088798800@192.168.203.155@tcp:28/4 lens 224/224 e 0 to 1 dl 1769077743 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4738.119961] Lustre: lustre-OST0000-osc-ffffa02088798800: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 4743.143967] Lustre: 99251:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769077732/real 1769077732] req@00000000c2970732 x1855012134197888/t0(0) o400->lustre-OST0000-osc-ffffa02088798800@192.168.203.155@tcp:28/4 lens 224/224 e 0 to 1 dl 1769077748 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4748.283183] Lustre: lustre-MDT0000-mdc-ffffa02088798800: Connection to lustre-MDT0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4764.640176] Lustre: 99249:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769077753/real 1769077753] req@000000008e7b1e9e x1855012134200448/t0(0) o400->MGC192.168.203.155@tcp@192.168.203.155@tcp:26/25 lens 224/224 e 0 to 1 dl 1769077769 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4764.662929] LustreError: MGC192.168.203.155@tcp: Connection to MGS (at 192.168.203.155@tcp) was lost; in progress operations using this service will fail [ 4774.892340] Lustre: Evicted from MGS (at 192.168.203.155@tcp) after server handle changed from 0x4299216f65ee82ab to 0x4299216f65ee8528 [ 4774.910248] Lustre: MGC192.168.203.155@tcp: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 4779.619645] Lustre: lustre-MDT0000-mdc-ffffa02088798800: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 4785.816295] LustreError: 107135:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02088798800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4785.831615] LustreError: 107135:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4785.958058] Lustre: Unmounted lustre-client [ 4817.522665] Key type lgssc unregistered [ 4817.764912] LNet: 107539:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4817.773801] LNetError: 107539:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4817.794986] LNet: Removed LNI 192.168.203.55@tcp [ 4818.645223] Key type .llcrypt unregistered [ 4818.646914] Key type ._llcrypt unregistered [ 4833.553348] Key type ._llcrypt registered [ 4833.555439] Key type .llcrypt registered [ 4834.865947] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 05:30:38 (1769077838) [ 4849.495117] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4849.505654] alg: No test for adler32 (adler32-zlib) [ 4850.614422] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 4850.884354] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 4852.600292] Key type lgssc registered [ 4853.827557] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4891.192359] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4979.267875] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4983.303809] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5003.501953] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5006.213929] Lustre: Mounted lustre-client [ 5008.144786] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5010.878828] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 05:33:34 (1769078014) [ 5223.052984] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5233.326459] LustreError: 118318:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5233.357110] Lustre: Unmounted lustre-client [ 5355.859374] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5359.544418] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5381.404338] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5434.817325] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:40:38 (1769078438) [ 5534.858103] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5540.777149] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5567.075171] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5567.652852] Lustre: Mounted lustre-client [ 5572.948128] LustreError: 125747:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02088632800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5572.975732] LustreError: 125747:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5572.978574] LustreError: 125747:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5573.051052] Lustre: Unmounted lustre-client [ 5602.759253] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 05:43:26 (1769078606) [ 5705.577758] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5710.630650] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5733.635469] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5734.245533] Lustre: Mounted lustre-client [ 5738.822397] LustreError: 129803:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208b39e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5738.851683] LustreError: 129803:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5738.855754] LustreError: 129803:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5738.968166] Lustre: Unmounted lustre-client [ 5766.439795] Key type lgssc unregistered [ 5766.740794] LNet: 130206:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5766.752508] LNetError: 130206:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5766.778236] LNet: Removed LNI 192.168.203.55@tcp [ 5767.598402] Key type .llcrypt unregistered [ 5767.600238] Key type ._llcrypt unregistered [ 5782.525438] Key type ._llcrypt registered [ 5782.530242] Key type .llcrypt registered [ 5783.954744] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 05:46:27 (1769078787) [ 5786.581040] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5786.664356] alg: No test for adler32 (adler32-zlib) [ 5787.707789] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 5788.006413] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 5789.728273] Key type lgssc registered [ 5791.035758] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5837.961847] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5842.821739] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5864.247339] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5867.104234] Lustre: Mounted lustre-client [ 5881.659919] LustreError: 133316:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208b39a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5881.718665] LustreError: 133316:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5881.849752] Lustre: Unmounted lustre-client [ 5917.476476] Key type lgssc unregistered [ 5917.715217] LNet: 133721:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5917.745427] LNetError: 133721:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5917.764331] LNet: Removed LNI 192.168.203.55@tcp [ 5918.444142] Key type .llcrypt unregistered [ 5918.451511] Key type ._llcrypt unregistered [ 5935.688298] Key type ._llcrypt registered [ 5935.690201] Key type .llcrypt registered [ 5937.407936] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 05:49:00 (1769078940) [ 5939.906395] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5939.934086] alg: No test for adler32 (adler32-zlib) [ 5941.240146] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 5941.600711] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 5943.386479] Key type lgssc registered [ 5945.245449] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5996.886531] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6001.162972] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6020.001656] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6022.809828] Lustre: Mounted lustre-client [ 6028.274908] Lustre: lustre-OST0000-osc-ffffa0208b39f000: Connection to lustre-OST0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6037.476399] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffffa0208b39f000.ost_server_uuid 50 [ 6039.110368] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6050.688354] LustreError: 137262:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208b39f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6050.717377] LustreError: 137262:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6050.752281] Lustre: Unmounted lustre-client [ 6074.967976] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 05:51:18 (1769079078) [ 6110.249298] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6116.567096] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6138.654819] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6160.663436] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6161.304661] Lustre: Mounted lustre-client [ 6166.527504] Lustre: lustre-OST0000-osc-ffffa02098e25000: Connection to lustre-OST0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6190.688975] LustreError: 139921:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02098e25000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6190.713838] LustreError: 139921:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 6190.718676] LustreError: 139921:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 6190.810904] Lustre: Unmounted lustre-client [ 6234.963994] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 05:53:58 (1769079238) [ 6262.911938] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6265.952455] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6282.674824] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6299.405472] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6299.928175] Lustre: Mounted lustre-client [ 6305.261394] Lustre: lustre-OST0000-osc-ffffa02086f35800: Connection to lustre-OST0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6328.929603] LustreError: 142681:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02086f35800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6328.944106] LustreError: 142681:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 6328.959618] LustreError: 142681:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 6328.964382] LustreError: 142681:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 6329.006813] Lustre: Unmounted lustre-client [ 6381.206892] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 05:56:24 (1769079384) [ 6454.495381] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6457.282424] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6472.907936] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6526.532482] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6529.618368] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6544.677391] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6568.359266] Lustre: Mounted lustre-client [ 6604.860190] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6614.399222] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 8 sec [ 6615.589400] LustreError: 149336:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208879e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6615.596709] LustreError: 149336:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 6615.612663] LustreError: 149336:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6615.617034] LustreError: 149336:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 6615.647473] Lustre: Unmounted lustre-client [ 6640.754973] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 06:00:44 (1769079644) [ 6661.194313] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6663.363167] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6674.358810] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6694.265055] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6715.651806] Lustre: Mounted lustre-client [ 6748.820844] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6749.855780] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6751.723582] Lustre: lustre-OST0001-osc-ffffa02086f34800: Connection to lustre-OST0001 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6759.610000] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6769.903755] LustreError: 152929:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 6769.911425] LustreError: 152929:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 6769.937049] Lustre: Unmounted lustre-client [ 6818.252551] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 06:03:42 (1769079822) [ 6837.758656] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6840.505878] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6854.057972] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6854.448132] Lustre: Mounted lustre-client [ 6868.575719] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6869.614462] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6877.625268] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffffa02084c91000.ost_server_uuid 50 [ 6878.667890] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffffa02084c91000.ost_server_uuid in FULL state after 0 sec [ 6880.971969] LustreError: 156350:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02084c91000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6880.990644] LustreError: 156350:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 6880.998884] LustreError: 156350:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 6881.030721] Lustre: Unmounted lustre-client [ 6881.287350] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6881.291950] Lustre: Skipped 3 previous similar messages [ 6881.386847] Lustre: Mounted lustre-client [ 6882.124453] LustreError: 156414:0:(sec.c:410:import_sec_validate_get()) import 000000008f2937ad (NEW) with no sec [ 6953.146580] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 06:05:57 (1769079957) [ 6971.555522] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6974.051776] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6985.710185] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6997.160449] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6997.465062] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6997.563450] Lustre: Mounted lustre-client [ 7006.203291] LustreError: 159262:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02085f0c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7006.208935] LustreError: 159262:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 7006.225277] LustreError: 159262:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 7006.228078] LustreError: 159262:0:(obd_class.h:479:obd_check_dev()) Skipped 18 previous similar messages [ 7006.274175] Lustre: Unmounted lustre-client [ 7006.275952] Lustre: Skipped 1 previous similar message [ 7043.237811] Key type lgssc unregistered [ 7043.409181] LNet: 159710:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7043.418710] LNetError: 159710:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7043.429412] LNet: Removed LNI 192.168.203.55@tcp [ 7043.842625] Key type .llcrypt unregistered [ 7043.844089] Key type ._llcrypt unregistered [ 7051.424203] Key type ._llcrypt registered [ 7051.426095] Key type .llcrypt registered [ 7052.057398] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 06:07:36 (1769080056) [ 7052.580874] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7052.597547] alg: No test for adler32 (adler32-zlib) [ 7053.528652] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 7053.700529] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 7055.328212] Key type lgssc registered [ 7055.955925] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7080.723151] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7082.250928] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7091.439827] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7101.713173] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7101.988803] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7103.092941] Lustre: Mounted lustre-client [ 7107.195237] LustreError: lustre-MDT0001-mdc-ffffa02086f35000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7107.206632] Lustre: lustre-MDT0001-mdc-ffffa02086f35000: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 7109.615299] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7110.460572] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7116.606662] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7123.898602] LustreError: 163898:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02086f35000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7123.908412] LustreError: 163898:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 7123.947148] Lustre: Unmounted lustre-client [ 7145.289812] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 06:09:09 (1769080149) [ 7201.713762] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7204.101529] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7217.006608] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7217.349261] Lustre: Mounted lustre-client [ 7228.321511] Lustre: 167949:0:(lov_ea.c:282:lsme_unpack()) lustre-clilov_UUID: FID 0x2c0000401:2 OST index 1/64 missing [ 7228.325541] Lustre: lustre-clilov_UUID: wait 30s while client connects to new OST [ 7232.210416] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7233.070603] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7244.266605] Lustre: lustre-OST0001-osc-ffffa0208b39b000: Connection to lustre-OST0001 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7248.312984] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7258.604386] LustreError: 168627:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 7258.606856] LustreError: 168627:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 7258.630962] Lustre: Unmounted lustre-client [ 7293.349546] Key type lgssc unregistered [ 7293.496466] LNet: 169031:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7293.500551] LNetError: 169031:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7293.511544] LNet: Removed LNI 192.168.203.55@tcp [ 7293.851942] Key type .llcrypt unregistered [ 7293.854030] Key type ._llcrypt unregistered [ 7312.484153] Key type ._llcrypt registered [ 7312.495480] Key type .llcrypt registered [ 7312.683169] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7312.690168] alg: No test for adler32 (adler32-zlib) [ 7313.569151] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 7313.670887] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 7315.296218] Key type lgssc registered [ 7315.886517] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7359.257750] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7361.225579] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7370.712221] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7394.704254] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 06:13:19 (1769080399) [ 7408.638231] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7410.249903] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7418.621747] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7424.005188] Lustre: Mounted lustre-client [ 7462.218559] LustreError: 175101:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020874b0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7462.229447] LustreError: 175101:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7462.255520] Lustre: Unmounted lustre-client [ 7482.699496] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7482.987449] Lustre: Mounted lustre-client [ 7515.540220] LustreError: 175759:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208b39f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7515.553965] LustreError: 175759:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7515.557395] LustreError: 175759:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 7515.588819] Lustre: Unmounted lustre-client [ 7534.359640] Key type lgssc unregistered [ 7534.490632] LNet: 176165:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7534.494566] LNetError: 176165:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7534.503903] LNet: Removed LNI 192.168.203.55@tcp [ 7534.813677] Key type .llcrypt unregistered [ 7534.815140] Key type ._llcrypt unregistered [ 7541.197283] Key type ._llcrypt registered [ 7541.198849] Key type .llcrypt registered [ 7541.769994] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 06:15:46 (1769080546) [ 7542.607873] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7542.628078] alg: No test for adler32 (adler32-zlib) [ 7543.527328] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 7543.644251] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 7545.264561] Key type lgssc registered [ 7545.824483] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7569.120688] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7570.469722] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7578.043350] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7588.856735] Lustre: Mounted lustre-client [ 7596.735811] LustreError: 179417:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02085f0a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7596.743768] LustreError: 179417:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7596.767675] Lustre: Unmounted lustre-client [ 7615.121412] Key type lgssc unregistered [ 7615.271300] LNet: 179818:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7615.275132] LNetError: 179818:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7615.284030] LNet: Removed LNI 192.168.203.55@tcp [ 7615.581558] Key type .llcrypt unregistered [ 7615.583247] Key type ._llcrypt unregistered [ 7620.794157] Key type ._llcrypt registered [ 7620.795298] Key type .llcrypt registered [ 7621.012717] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7621.019898] alg: No test for adler32 (adler32-zlib) [ 7621.948121] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 7622.072084] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 7623.666110] Key type lgssc registered [ 7624.233161] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7646.619212] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7648.002500] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7655.459278] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7666.191086] Lustre: Mounted lustre-client [ 7669.769106] LustreError: 182385:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020898e3000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7669.783194] LustreError: 182385:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7669.814873] Lustre: Unmounted lustre-client [ 7696.496929] Key type lgssc unregistered [ 7696.621846] LNet: 182788:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7696.625105] LNetError: 182788:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7696.634774] LNet: Removed LNI 192.168.203.55@tcp [ 7696.908239] Key type .llcrypt unregistered [ 7696.910105] Key type ._llcrypt unregistered [ 7702.981612] Key type ._llcrypt registered [ 7702.982775] Key type .llcrypt registered [ 7703.503420] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 06:18:27 (1769080707) [ 7704.473991] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7704.483657] alg: No test for adler32 (adler32-zlib) [ 7705.352497] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 7705.443355] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 7707.040155] Key type lgssc registered [ 7707.522324] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7728.486725] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7730.040036] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7737.599673] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7748.108897] Lustre: Mounted lustre-client [ 7757.723765] LustreError: 186046:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02082af8000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7757.735498] LustreError: 186046:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7757.766325] Lustre: Unmounted lustre-client [ 7786.642320] Key type lgssc unregistered [ 7786.787543] LNet: 186449:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7786.789912] LNetError: 186449:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7786.801144] LNet: Removed LNI 192.168.203.55@tcp [ 7787.095461] Key type .llcrypt unregistered [ 7787.100137] Key type ._llcrypt unregistered [ 7792.472925] Key type ._llcrypt registered [ 7792.474539] Key type .llcrypt registered [ 7792.703802] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7792.711178] alg: No test for adler32 (adler32-zlib) [ 7793.618478] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 7793.723802] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 7795.320160] Key type lgssc registered [ 7795.837526] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7816.502477] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7818.182159] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7825.767328] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7836.204347] Lustre: Mounted lustre-client [ 7839.681094] LustreError: 189014:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02084c97000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7839.694070] LustreError: 189014:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7839.725131] Lustre: Unmounted lustre-client [ 7866.830740] Key type lgssc unregistered [ 7866.971753] LNet: 189417:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7866.975869] LNetError: 189417:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7866.987746] LNet: Removed LNI 192.168.203.55@tcp [ 7867.283753] Key type .llcrypt unregistered [ 7867.285082] Key type ._llcrypt unregistered [ 7874.370231] Key type ._llcrypt registered [ 7874.373061] Key type .llcrypt registered [ 7875.097893] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 06:21:19 (1769080879) [ 7884.504257] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7884.541775] alg: No test for adler32 (adler32-zlib) [ 7885.436932] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 7885.535721] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 7887.152192] Key type lgssc registered [ 7887.706744] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7923.771879] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7925.297778] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7933.837711] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7958.971520] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 06:22:43 (1769080963) [ 7969.092774] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7970.301454] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7976.705218] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7992.312307] Lustre: Mounted lustre-client [ 7994.366139] LustreError: 195918:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020a0355800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7994.376084] LustreError: 195918:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7994.400327] Lustre: Unmounted lustre-client [ 8012.904949] Key type lgssc unregistered [ 8013.019428] LNet: 196319:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8013.021980] LNetError: 196319:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8013.031725] LNet: Removed LNI 192.168.203.55@tcp [ 8013.260389] Key type .llcrypt unregistered [ 8013.262051] Key type ._llcrypt unregistered [ 8018.708273] Key type ._llcrypt registered [ 8018.709656] Key type .llcrypt registered [ 8019.232790] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8019.800601] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 06:23:44 (1769081024) [ 8026.210195] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8026.226452] alg: No test for adler32 (adler32-zlib) [ 8027.085821] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 8027.174224] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 8028.760171] Key type lgssc registered [ 8029.172975] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8090.160697] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8094.340927] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8120.674573] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 8135.545750] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 8138.184698] Lustre: Mounted lustre-client [ 8152.663502] LustreError: 201857:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02089b94800: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 8152.679614] LustreError: 201857:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8152.730952] Lustre: Unmounted lustre-client [ 8263.731798] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8266.220670] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8282.049192] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8316.456783] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 06:28:40 (1769081320) [ 8317.709632] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8319.090126] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 06:28:43 (1769081323) [ 8361.839636] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8364.499202] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8386.589261] Key type lgssc unregistered [ 8386.782348] LNet: 208037:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8386.792764] LNetError: 208037:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8386.811535] LNet: Removed LNI 192.168.203.55@tcp [ 8387.285701] Key type .llcrypt unregistered [ 8387.288447] Key type ._llcrypt unregistered [ 8398.080711] Key type ._llcrypt registered [ 8398.082655] Key type .llcrypt registered [ 8398.987862] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 06:30:02 (1769081402) [ 8422.640296] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8422.655291] alg: No test for adler32 (adler32-zlib) [ 8423.588958] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 8423.751146] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 8425.368161] Key type lgssc registered [ 8426.804431] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8466.626110] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8469.857333] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8484.835251] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8508.790051] Key type lgssc unregistered [ 8509.014579] LNet: 211672:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8509.018678] LNetError: 211672:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8509.030562] LNet: Removed LNI 192.168.203.55@tcp [ 8509.620399] Key type .llcrypt unregistered [ 8509.622554] Key type ._llcrypt unregistered [ 8520.242761] Key type ._llcrypt registered [ 8520.246380] Key type .llcrypt registered [ 8521.023934] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 06:32:05 (1769081525) [ 8522.746279] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8522.755389] alg: No test for adler32 (adler32-zlib) [ 8523.710241] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 8523.914470] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 8525.536145] Key type lgssc registered [ 8526.369184] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8561.362854] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8563.503832] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8574.881903] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8577.282438] Lustre: Mounted lustre-client [ 8587.753134] Lustre: lustre-MDT0000-mdc-ffffa0208879e800: Connection to lustre-MDT0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8592.870361] Lustre: lustre-MDT0001-mdc-ffffa0208879e800: Connection to lustre-MDT0001 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8608.226319] Lustre: 212658:0:(client.c:2478:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1769081597/real 1769081597] req@0000000055c5327b x1855016432386304/t0(0) o400->MGC192.168.203.155@tcp@192.168.203.155@tcp:26/25 lens 224/224 e 0 to 1 dl 1769081613 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 8608.228776] LustreError: MGC192.168.203.155@tcp: Connection to MGS (at 192.168.203.155@tcp) was lost; in progress operations using this service will fail [ 8608.252201] Lustre: Evicted from MGS (at 192.168.203.155@tcp) after server handle changed from 0xaa7e75c29a999b49 to 0xaa7e75c29a99b48d [ 8608.258269] Lustre: MGC192.168.203.155@tcp: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 8622.582136] LustreError: lustre-MDT0000-mdc-ffffa0208879e800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 8622.603798] Lustre: lustre-MDT0000-mdc-ffffa0208879e800: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 8624.908476] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8625.523752] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8626.961413] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8634.722882] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 7 sec [ 8635.558786] LustreError: 216132:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208879e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8635.565268] LustreError: 216132:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8635.586109] Lustre: Unmounted lustre-client [ 8653.056106] Key type lgssc unregistered [ 8653.173432] LNet: 216533:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8653.176231] LNetError: 216533:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8653.186096] LNet: Removed LNI 192.168.203.55@tcp [ 8653.429708] Key type .llcrypt unregistered [ 8653.430953] Key type ._llcrypt unregistered [ 8659.474501] Key type ._llcrypt registered [ 8659.475864] Key type .llcrypt registered [ 8660.008084] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 06:34:24 (1769081664) [ 8660.851312] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8660.893386] alg: No test for adler32 (adler32-zlib) [ 8661.752803] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 8661.836811] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 8663.424263] Key type lgssc registered [ 8663.841304] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8682.449609] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8683.728201] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8707.024747] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8708.297173] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8718.620205] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8728.523216] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 8754.871428] Key type lgssc unregistered [ 8754.995424] LNet: 221633:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8754.998651] LNetError: 221633:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8755.008364] LNet: Removed LNI 192.168.203.55@tcp [ 8755.232303] Key type .llcrypt unregistered [ 8755.233367] Key type ._llcrypt unregistered [ 8771.873317] Key type ._llcrypt registered [ 8771.875354] Key type .llcrypt registered [ 8772.058143] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8772.063358] alg: No test for adler32 (adler32-zlib) [ 8772.970695] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 8773.074448] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 8774.664141] Key type lgssc registered [ 8775.121905] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8809.767441] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8811.062921] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8819.097198] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8841.185711] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 06:37:25 (1769081845) [ 8880.412749] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8881.703874] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8889.456949] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8910.608207] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 06:38:35 (1769081915) [ 8913.054254] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 06:38:37 (1769081917) [ 8924.380238] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8925.568147] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8932.140068] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8942.578969] Lustre: Mounted lustre-client [ 8945.850192] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 8946.584090] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 8947.145838] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 8947.773275] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 8952.805379] Lustre: lustre-MDT0000-mdc-ffffa02098e3d800: Connection to lustre-MDT0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8963.046698] LustreError: MGC192.168.203.155@tcp: Connection to MGS (at 192.168.203.155@tcp) was lost; in progress operations using this service will fail [ 8963.054282] Lustre: Evicted from MGS (at 192.168.203.155@tcp) after server handle changed from 0xe61f7c117bcfcf4 to 0xe61f7c117bcff5c [ 8963.058755] Lustre: MGC192.168.203.155@tcp: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 8967.158281] Lustre: lustre-MDT0000-mdc-ffffa02098e3d800: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 8968.314490] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8968.844613] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8970.700917] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 8973.282948] Lustre: lustre-MDT0000-mdc-ffffa02098e3d800: Connection to lustre-MDT0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8988.645540] LustreError: MGC192.168.203.155@tcp: Connection to MGS (at 192.168.203.155@tcp) was lost; in progress operations using this service will fail [ 8988.658335] Lustre: Evicted from MGS (at 192.168.203.155@tcp) after server handle changed from 0xe61f7c117bcff5c to 0xe61f7c117bd025e [ 8988.664555] Lustre: MGC192.168.203.155@tcp: Connection restored to 192.168.203.155@tcp (at 192.168.203.155@tcp) [ 8991.002231] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8991.651337] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8993.256402] LustreError: 235224:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02098e3d800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8993.264192] LustreError: 235224:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8993.285803] Lustre: Unmounted lustre-client [ 9027.358207] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9028.547763] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9034.965183] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9045.509804] Lustre: Mounted lustre-client [ 9045.976499] LustreError: 236840:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa0208879c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9045.988557] LustreError: 236840:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9045.992870] LustreError: 236840:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 9046.023326] Lustre: Unmounted lustre-client [ 9072.028360] Key type lgssc unregistered [ 9072.137424] LNet: 237243:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9072.140176] LNetError: 237243:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9072.147764] LNet: Removed LNI 192.168.203.55@tcp [ 9072.382260] Key type .llcrypt unregistered [ 9072.383623] Key type ._llcrypt unregistered [ 9077.787569] Key type ._llcrypt registered [ 9077.788599] Key type .llcrypt registered [ 9078.285058] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 06:41:22 (1769082082) [ 9079.740515] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9079.748669] alg: No test for adler32 (adler32-zlib) [ 9080.614968] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 9080.702694] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 9082.288184] Key type lgssc registered [ 9082.713101] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9101.176908] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9102.412558] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9108.789514] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9119.225070] Lustre: Mounted lustre-client [ 9122.186839] LustreError: 240407:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02085b45800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9122.196325] LustreError: 240407:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9122.217983] Lustre: Unmounted lustre-client [ 9154.583137] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9155.960599] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9162.634931] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9172.979088] Lustre: Mounted lustre-client [ 9179.169091] LustreError: 242002:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020854bd800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9179.177210] LustreError: 242002:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9179.179581] LustreError: 242002:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 9179.201146] Lustre: Unmounted lustre-client [ 9212.170593] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9213.408165] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9220.417523] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9230.836660] Lustre: Mounted lustre-client [ 9231.166859] LustreError: 243613:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02082afc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9231.174577] LustreError: 243613:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9231.176713] LustreError: 243613:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 9231.198753] Lustre: Unmounted lustre-client [ 9257.421829] Key type lgssc unregistered [ 9257.552546] LNet: 244016:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9257.555479] LNetError: 244016:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9257.565742] LNet: Removed LNI 192.168.203.55@tcp [ 9257.812904] Key type .llcrypt unregistered [ 9257.814684] Key type ._llcrypt unregistered [ 9263.587350] Key type ._llcrypt registered [ 9263.588689] Key type .llcrypt registered [ 9264.150777] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 06:44:28 (1769082268) [ 9265.422374] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9265.428672] alg: No test for adler32 (adler32-zlib) [ 9266.286461] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 9266.371710] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 9267.960154] Key type lgssc registered [ 9268.345508] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9284.346993] Key type lgssc unregistered [ 9284.464289] LNet: 246324:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9284.467470] LNetError: 246324:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9284.475314] LNet: Removed LNI 192.168.203.55@tcp [ 9284.702582] Key type .llcrypt unregistered [ 9284.704175] Key type ._llcrypt unregistered [ 9294.137108] Key type ._llcrypt registered [ 9294.138523] Key type .llcrypt registered [ 9294.377480] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9294.386259] alg: No test for adler32 (adler32-zlib) [ 9295.241489] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 9295.328848] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 9296.912142] Key type lgssc registered [ 9297.281964] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9326.654725] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9327.784351] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9335.566735] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9368.394674] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 9368.993251] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 06:46:13 (1769082373) [ 9380.237065] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9381.488859] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9387.667829] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9395.554474] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 9396.736643] Lustre: Mounted lustre-client [ 9401.828901] Lustre: lustre-OST0001-osc-ffffa020854bc800: Connection to lustre-OST0001 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9404.544838] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9414.823597] LustreError: 252803:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 9414.840094] Lustre: Unmounted lustre-client [ 9454.903177] Key type lgssc unregistered [ 9455.024671] LNet: 253210:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9455.027530] LNetError: 253210:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9455.038811] LNet: Removed LNI 192.168.203.55@tcp [ 9455.297693] Key type .llcrypt unregistered [ 9455.299044] Key type ._llcrypt unregistered [ 9469.905935] Key type ._llcrypt registered [ 9469.907146] Key type .llcrypt registered [ 9470.116861] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9470.128596] alg: No test for adler32 (adler32-zlib) [ 9470.989096] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 9471.073719] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 9472.656129] Key type lgssc registered [ 9473.053788] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9501.902089] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9503.046405] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9510.934720] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9532.583697] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 06:48:57 (1769082537) [ 9546.076798] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9547.291289] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9558.936732] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 06:49:23 (1769082563) [ 9568.901855] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9570.087541] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9576.570887] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9588.208626] Lustre: Mounted lustre-client [ 9591.850053] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 9602.071912] LustreError: 261054:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9602.090647] Lustre: Unmounted lustre-client [ 9656.682170] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9657.899392] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9686.396724] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9696.754918] Lustre: Mounted lustre-client [ 9697.117948] LustreError: 263107:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02085b40000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9697.124092] LustreError: 263107:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9697.125687] LustreError: 263107:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 9697.144470] Lustre: Unmounted lustre-client [ 9713.991223] Key type lgssc unregistered [ 9714.099535] LNet: 263508:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9714.101985] LNetError: 263508:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9714.110642] LNet: Removed LNI 192.168.203.55@tcp [ 9714.343698] Key type .llcrypt unregistered [ 9714.345442] Key type ._llcrypt unregistered [ 9722.820759] Key type ._llcrypt registered [ 9722.821874] Key type .llcrypt registered [ 9723.015467] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9723.024903] alg: No test for adler32 (adler32-zlib) [ 9723.880196] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 9723.963929] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 9725.544208] Key type lgssc registered [ 9725.955595] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9754.278654] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9755.401698] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9762.657452] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9794.767839] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 9795.336672] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 06:53:19 (1769082799) [ 9805.419393] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9806.670579] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9812.943274] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9824.239251] Lustre: Mounted lustre-client [ 9825.069746] LustreError: 269541:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020898e4800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9825.083131] LustreError: 269541:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9825.105179] Lustre: Unmounted lustre-client [ 9842.501846] Key type lgssc unregistered [ 9842.625414] LNet: 269943:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9842.627907] LNetError: 269943:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9842.634770] LNet: Removed LNI 192.168.203.55@tcp [ 9842.887552] Key type .llcrypt unregistered [ 9842.888655] Key type ._llcrypt unregistered [ 9847.750774] Key type ._llcrypt registered [ 9847.752135] Key type .llcrypt registered [ 9848.193327] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 9848.707803] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 06:54:13 (1769082853) [ 9851.693550] Key type .llcrypt unregistered [ 9851.694987] Key type ._llcrypt unregistered [ 9854.640799] Key type ._llcrypt registered [ 9854.642450] Key type .llcrypt registered [ 9854.848733] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9854.855019] alg: No test for adler32 (adler32-zlib) [ 9855.723172] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 9855.820183] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 9857.408136] Key type lgssc registered [ 9857.834319] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9874.229839] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9879.669581] Lustre: Mounted lustre-client [ 9880.140602] LustreError: 272950:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020891bb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9880.148447] LustreError: 272950:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9880.170103] Lustre: Unmounted lustre-client [ 9897.620817] Key type lgssc unregistered [ 9897.739711] LNet: 273352:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9897.742305] LNetError: 273352:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9897.753314] LNet: Removed LNI 192.168.203.55@tcp [ 9898.041251] Key type .llcrypt unregistered [ 9898.042490] Key type ._llcrypt unregistered [ 9903.907434] Key type ._llcrypt registered [ 9903.908453] Key type .llcrypt registered [ 9904.410485] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 06:55:08 (1769082908) [ 9905.180249] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9905.211545] alg: No test for adler32 (adler32-zlib) [ 9906.100406] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [ 9906.203975] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [ 9907.808167] Key type lgssc registered [ 9908.194644] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9967.608604] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9977.183533] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9978.267185] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9983.473575] Lustre: Mounted lustre-client [ 9983.934373] LustreError: 276389:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02082afc000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9983.943299] LustreError: 276389:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9983.966994] Lustre: Unmounted lustre-client [10001.559772] Key type lgssc unregistered [10001.682634] LNet: 276791:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10001.685986] LNetError: 276791:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10001.695683] LNet: Removed LNI 192.168.203.55@tcp [10001.980465] Key type .llcrypt unregistered [10001.982815] Key type ._llcrypt unregistered [10009.373667] Key type ._llcrypt registered [10009.375175] Key type .llcrypt registered [10009.948564] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 06:56:54 (1769083014) [10011.063534] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10011.090218] alg: No test for adler32 (adler32-zlib) [10011.992606] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [10012.093091] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [10013.688179] Key type lgssc registered [10014.242618] Lustre: Echo OBD driver; http://www.lustre.org/ [10033.833982] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10035.047622] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10040.999134] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10051.566855] Lustre: Mounted lustre-client [10056.675624] Lustre: lustre-MDT0000-mdc-ffffa02086c15000: Connection to lustre-MDT0000 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [10059.224913] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10059.235751] LustreError: 279852:0:(file.c:6123:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [10059.340622] LustreError: 279871:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02086c15000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10059.345361] LustreError: MGC192.168.203.155@tcp: Connection to MGS (at 192.168.203.155@tcp) was lost; in progress operations using this service will fail [10059.348515] LustreError: 279871:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10059.366579] Lustre: Unmounted lustre-client [10070.063529] Key type lgssc unregistered [10070.193328] LNet: 280264:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10070.195818] LNetError: 280264:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10070.203271] LNet: Removed LNI 192.168.203.55@tcp [10070.438367] Key type .llcrypt unregistered [10070.440299] Key type ._llcrypt unregistered [10075.748886] Key type ._llcrypt registered [10075.749772] Key type .llcrypt registered [10076.229502] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 06:58:00 (1769083080) [10076.926974] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10076.966707] alg: No test for adler32 (adler32-zlib) [10077.830351] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [10077.910881] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [10079.496158] Key type lgssc registered [10079.887342] Lustre: Echo OBD driver; http://www.lustre.org/ [10096.379775] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10097.535736] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10103.426831] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10119.151910] Lustre: Mounted lustre-client [10124.260597] Lustre: lustre-MDT0001-mdc-ffffa020873f5000: Connection to lustre-MDT0001 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [10126.801581] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [10127.202639] LustreError: 283356:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020873f5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10127.214937] LustreError: 283356:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10127.233092] Lustre: Unmounted lustre-client [10137.960894] Key type lgssc unregistered [10138.069500] LNet: 283750:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10138.072278] LNetError: 283750:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10138.081848] LNet: Removed LNI 192.168.203.55@tcp [10138.315771] Key type .llcrypt unregistered [10138.317202] Key type ._llcrypt unregistered [10143.546460] Key type ._llcrypt registered [10143.547761] Key type .llcrypt registered [10143.986356] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 06:59:08 (1769083148) [10149.738475] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10149.782359] alg: No test for adler32 (adler32-zlib) [10150.659956] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [10150.755276] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [10152.344125] Key type lgssc registered [10152.726982] Lustre: Echo OBD driver; http://www.lustre.org/ [10189.576887] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10195.929823] Lustre: Mounted lustre-client [10216.419204] Lustre: lustre-MDT0001-mdc-ffffa02085bce000: Connection to lustre-MDT0001 (at 192.168.203.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [10218.945529] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10229.223388] LustreError: 289087:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [10229.237103] Lustre: Unmounted lustre-client [10250.493831] Key type lgssc unregistered [10250.658193] LNet: 289487:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10250.664718] LNetError: 289487:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10250.677485] LNet: Removed LNI 192.168.203.55@tcp [10251.070909] Key type .llcrypt unregistered [10251.072835] Key type ._llcrypt unregistered [10265.796653] Key type ._llcrypt registered [10265.800078] Key type .llcrypt registered [10267.018596] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 07:01:10 (1769083270) [10268.692082] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [10270.743273] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 07:01:14 (1769083274) [10272.680405] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [10274.665399] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 07:01:18 (1769083278) [10276.241161] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [10278.233716] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 07:01:21 (1769083281) [10279.751661] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [10281.762369] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 07:01:25 (1769083285) [10283.319230] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [10284.798472] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 07:01:28 (1769083288) [10291.196395] Key type .llcrypt unregistered [10291.197482] Key type ._llcrypt unregistered [10295.270139] Key type ._llcrypt registered [10295.272293] Key type .llcrypt registered [10295.493898] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10295.504576] alg: No test for adler32 (adler32-zlib) [10296.454753] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [10296.605845] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [10298.224189] Key type lgssc registered [10298.955585] Lustre: Echo OBD driver; http://www.lustre.org/ [10336.923939] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10339.092180] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10351.337738] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10358.245722] Lustre: Mounted lustre-client [10359.454977] LustreError: 295081:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020873f5800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10359.467745] LustreError: 295081:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10359.511265] Lustre: Unmounted lustre-client [10386.487530] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 07:03:10 (1769083390) [10402.005945] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10403.963074] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10414.642182] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10420.240111] Lustre: Mounted lustre-client [10421.015411] LustreError: 297192:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020891b9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10421.029870] LustreError: 297192:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10421.034153] LustreError: 297192:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [10421.075069] Lustre: Unmounted lustre-client [10442.741904] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 07:04:07 (1769083447) [10470.688373] LNet: 1 local NIs in recovery (showing 1): 192.168.203.55@tcp [10478.824400] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10480.502753] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10489.844413] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10542.826785] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 07:05:47 (1769083547) [10548.115617] Key type lgssc unregistered [10548.255220] LNet: 302633:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10548.260640] LNetError: 302633:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10548.274900] LNet: Removed LNI 192.168.203.55@tcp [10548.537823] Key type .llcrypt unregistered [10548.539475] Key type ._llcrypt unregistered [10677.220226] Key type ._llcrypt registered [10677.223371] Key type .llcrypt registered [10677.540481] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10677.552604] alg: No test for adler32 (adler32-zlib) [10678.572752] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [10678.732069] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [10680.376163] Key type lgssc registered [10681.063673] Lustre: Echo OBD driver; http://www.lustre.org/ [10742.656379] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10745.461931] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10758.740410] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10783.457688] Key type lgssc unregistered [10783.599433] LNet: 306232:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10783.603502] LNetError: 306232:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10783.617327] LNet: Removed LNI 192.168.203.55@tcp [10783.900511] Key type .llcrypt unregistered [10783.904068] Key type ._llcrypt unregistered [10790.894457] Key type ._llcrypt registered [10790.898182] Key type .llcrypt registered [10791.567428] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 07:09:55 (1769083795) [10802.667788] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10802.678865] alg: No test for adler32 (adler32-zlib) [10803.672432] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [10803.860040] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [10805.560865] Key type lgssc registered [10806.356646] Lustre: Echo OBD driver; http://www.lustre.org/ [10829.624879] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 07:10:34 (1769083834) [10834.299775] Key type lgssc unregistered [10834.424674] LNet: 309775:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10834.427909] LNetError: 309775:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10834.436426] LNet: Removed LNI 192.168.203.55@tcp [10834.707294] Key type .llcrypt unregistered [10834.708449] Key type ._llcrypt unregistered [10839.329762] Key type ._llcrypt registered [10839.336246] Key type .llcrypt registered [10839.568952] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10839.579509] alg: No test for adler32 (adler32-zlib) [10840.480975] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [10840.576920] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [10842.184302] Key type lgssc registered [10842.701341] Lustre: Echo OBD driver; http://www.lustre.org/ [10867.060588] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10868.437565] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10877.230123] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10970.322920] LNet: Added LNI 192.168.203.55@tcp50 [8/256/0/180] [10971.235730] LNet: Removed LNI 192.168.203.55@tcp [10972.661111] Lustre: 314048:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffffa020836da800: config has no valid NIDs, force dynamic NIDs [10973.721241] Lustre: Mounted lustre-client [10973.748129] LustreError: 314063:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa020836da800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10973.756144] LustreError: 314063:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10973.777737] Lustre: Unmounted lustre-client [10993.485573] Key type lgssc unregistered [10993.645351] LNet: 314901:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10993.648562] LNetError: 314901:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10993.658675] LNet: Removed LNI 192.168.203.55@tcp50 [10993.915574] Key type .llcrypt unregistered [10993.917950] Key type ._llcrypt unregistered [11027.761217] Key type ._llcrypt registered [11027.762493] Key type .llcrypt registered [11028.279483] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 07:13:52 (1769084032) [11029.125604] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11029.135296] alg: No test for adler32 (adler32-zlib) [11029.993221] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [11030.076179] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [11031.664157] Key type lgssc registered [11032.089444] Lustre: Echo OBD driver; http://www.lustre.org/ [11050.564495] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11051.985171] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11058.434269] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11068.912168] Lustre: Mounted lustre-client [11091.917421] Lustre: Mounted fs15246-client [11097.365343] LustreError: 319031:0:(lov_obd.c:783:lov_cleanup()) fs15246-clilov-ffffa0208334e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11097.375784] LustreError: 319031:0:(obd_class.h:479:obd_check_dev()) Device 8 not setup [11097.388688] Lustre: Unmounted fs15246-client [11110.587967] LustreError: 319248:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffffa02098e39800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11110.592728] LustreError: 319248:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [11110.595332] LustreError: 319248:0:(obd_class.h:479:obd_check_dev()) Skipped 3 previous similar messages [11110.613841] Lustre: Unmounted lustre-client [11128.196100] Key type lgssc unregistered [11128.313640] LNet: 319649:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11128.316256] LNetError: 319649:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11128.330188] LNet: Removed LNI 192.168.203.55@tcp [11128.566521] Key type .llcrypt unregistered [11128.567615] Key type ._llcrypt unregistered [11132.344154] Key type ._llcrypt registered [11132.345445] Key type .llcrypt registered [11132.829277] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 07:15:37 (1769084137) [11133.423931] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11133.432519] alg: No test for adler32 (adler32-zlib) [11134.337705] Lustre: Lustre: Build Version: 2.17.50_4_g8fdf1cc [11134.422327] LNet: Added LNI 192.168.203.55@tcp [8/256/0/180] [11136.008369] Key type lgssc registered [11136.392052] Lustre: Echo OBD driver; http://www.lustre.org/ [11187.774125] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11189.146757] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11197.713502] Lustre: DEBUG MARKER: oleg355-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11243.650376] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 11020 sec ========= 07:17:28 (1769084248) [11244.276119] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 07:17:28 (1769084248) === [11245.677911] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 07:17:30 (1769084250) === [11259.032450] Key type lgssc unregistered [11259.158718] LNet: 328785:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11259.162337] LNetError: 328785:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11259.169467] LNet: Removed LNI 192.168.203.55@tcp [11259.428434] Key type .llcrypt unregistered [11259.429614] Key type ._llcrypt unregistered