[ 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 421895867 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, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001012] APIC: Switch to symmetric I/O mode setup [ 0.002371] x2apic enabled [ 0.004005] Switched APIC routing to physical x2apic. [ 0.005013] kvm-guest: setup PV IPIs [ 0.007642] ..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.008022] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009011] pid_max: default: 32768 minimum: 301 [ 0.010139] LSM: Security Framework initializing [ 0.011054] Yama: becoming mindful. [ 0.012048] SELinux: Initializing. [ 0.013106] *** VALIDATE selinux *** [ 0.022459] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027064] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028158] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029123] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030113] *** VALIDATE tmpfs *** [ 0.031455] *** VALIDATE proc *** [ 0.033227] *** VALIDATE cgroup *** [ 0.034009] *** VALIDATE cgroup2 *** [ 0.035252] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036139] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038005] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039022] Spectre V2 : User space: Vulnerable [ 0.040004] Speculative Store Bypass: Vulnerable [ 0.042737] debug: unmapping init [mem 0xffffffffbcc59000-0xffffffffbcc60fff] [ 0.044000] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044503] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045015] ... version: 2 [ 0.045794] ... bit width: 48 [ 0.046007] ... generic registers: 4 [ 0.046717] ... value mask: 0000ffffffffffff [ 0.047008] ... max period: 00007fffffffffff [ 0.048008] ... fixed-purpose events: 3 [ 0.049006] ... event mask: 000000070000000f [ 0.050217] rcu: Hierarchical SRCU implementation. [ 0.052066] smp: Bringing up secondary CPUs ... [ 0.053529] x86: Booting SMP configuration: [ 0.054025] .... node #0, CPUs: #1 #2 #3 [ 0.058235] smp: Brought up 1 node, 4 CPUs [ 0.060010] smpboot: Max logical packages: 1 [ 0.061017] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.126940] node 0 deferred pages initialised in 63ms [ 0.130164] devtmpfs: initialized [ 0.131198] x86/mm: Memory block size: 128MB [ 0.134770] gcov: version magic: 0x41383552 [ 0.135637] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.138089] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.139220] pinctrl core: initialized pinctrl subsystem [ 0.140143] [ 0.140653] ************************************************************* [ 0.141013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.142007] ** ** [ 0.143008] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.144008] ** ** [ 0.145009] ** This means that this kernel is built to expose internal ** [ 0.146019] ** IOMMU data structures, which may compromise security on ** [ 0.147006] ** your system. ** [ 0.148008] ** ** [ 0.149005] ** If you see this message and you are not debugging the ** [ 0.150006] ** kernel, report this immediately to your vendor! ** [ 0.151007] ** ** [ 0.152007] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.153007] ************************************************************* [ 0.154655] NET: Registered protocol family 16 [ 0.155443] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.156033] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.157050] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.158467] cpuidle: using governor menu [ 0.160207] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.162405] PCI: Using configuration type 1 for base access [ 0.164090] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.170234] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.171000] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.172242] cryptd: max_cpu_qlen set to 1000 [ 0.175231] ACPI: Added _OSI(Module Device) [ 0.176011] ACPI: Added _OSI(Processor Device) [ 0.177014] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.178013] ACPI: Added _OSI(Processor Aggregator Device) [ 0.181213] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.183466] ACPI: Interpreter enabled [ 0.184056] ACPI: PM: (supports S0 S3 S4 S5) [ 0.184986] ACPI: Using IOAPIC for interrupt routing [ 0.185095] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.186323] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.195469] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.196033] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.197012] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.198073] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.201257] acpiphp: Slot [2] registered [ 0.202121] acpiphp: Slot [5] registered [ 0.203133] acpiphp: Slot [6] registered [ 0.204098] acpiphp: Slot [3] registered [ 0.205050] acpiphp: Slot [4] registered [ 0.206081] acpiphp: Slot [7] registered [ 0.207120] acpiphp: Slot [8] registered [ 0.208082] acpiphp: Slot [9] registered [ 0.209030] acpiphp: Slot [10] registered [ 0.209951] acpiphp: Slot [11] registered [ 0.210045] acpiphp: Slot [12] registered [ 0.211070] acpiphp: Slot [13] registered [ 0.212106] acpiphp: Slot [14] registered [ 0.213150] acpiphp: Slot [15] registered [ 0.214192] acpiphp: Slot [16] registered [ 0.215189] acpiphp: Slot [17] registered [ 0.216124] acpiphp: Slot [18] registered [ 0.217147] acpiphp: Slot [19] registered [ 0.218091] acpiphp: Slot [20] registered [ 0.219080] acpiphp: Slot [21] registered [ 0.220065] acpiphp: Slot [22] registered [ 0.221151] acpiphp: Slot [23] registered [ 0.222119] acpiphp: Slot [24] registered [ 0.223130] acpiphp: Slot [25] registered [ 0.224095] acpiphp: Slot [26] registered [ 0.225088] acpiphp: Slot [27] registered [ 0.226185] acpiphp: Slot [28] registered [ 0.227076] acpiphp: Slot [29] registered [ 0.228084] acpiphp: Slot [30] registered [ 0.229162] acpiphp: Slot [31] registered [ 0.230044] PCI host bridge to bus 0000:00 [ 0.231014] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.232015] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.233013] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.234014] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.235015] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.236103] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.237414] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.240394] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.244397] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.252012] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.256136] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.259018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.261024] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.263016] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.266523] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.269809] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.272051] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.274907] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.278011] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.285015] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.289011] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.292000] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.296019] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.300024] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.312025] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.330134] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.347019] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.354028] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.366939] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.377000] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.380479] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.384460] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.387435] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.390279] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.397079] iommu: Default domain type: Passthrough [ 0.399668] SCSI subsystem initialized [ 0.402227] ACPI: bus type USB registered [ 0.404284] usbcore: registered new interface driver usbfs [ 0.407121] usbcore: registered new interface driver hub [ 0.410122] usbcore: registered new device driver usb [ 0.413264] pps_core: LinuxPPS API ver. 1 registered [ 0.416018] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.420198] PTP clock support registered [ 0.424059] EDAC MC: Ver: 3.0.0 [ 0.426598] PCI: Using ACPI for IRQ routing [ 0.430091] NetLabel: Initializing [ 0.433016] NetLabel: domain hash size = 128 [ 0.436014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.438082] NetLabel: unlabeled traffic allowed by default [ 0.440144] vgaarb: loaded [ 0.441244] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.442000] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.445971] clocksource: Switched to clocksource kvm-clock [ 0.579229] VFS: Disk quotas dquot_6.6.0 [ 0.580208] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.581690] *** VALIDATE ramfs *** [ 0.582436] *** VALIDATE hugetlbfs *** [ 0.583434] pnp: PnP ACPI init [ 0.585149] pnp: PnP ACPI: found 6 devices [ 0.599641] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.602027] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.604130] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.606355] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.608998] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.611471] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.614347] NET: Registered protocol family 2 [ 0.617131] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.623394] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.626870] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.632209] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.635859] TCP: Hash tables configured (established 65536 bind 65536) [ 0.639075] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.642296] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.644804] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.646937] NET: Registered protocol family 1 [ 0.649815] RPC: Registered named UNIX socket transport module. [ 0.652935] RPC: Registered udp transport module. [ 0.654544] RPC: Registered tcp transport module. [ 0.656314] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.659200] NET: Registered protocol family 44 [ 0.660951] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.663319] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.665640] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.668215] PCI: CLS 0 bytes, default 64 [ 0.670316] Unpacking initramfs... [ 2.523601] debug: unmapping init [mem 0xffff8ee67cc64000-0xffff8ee67ffcffff] [ 2.528919] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.530878] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.533270] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 3.122982] Initialise system trusted keyrings [ 3.124230] Key type blacklist registered [ 3.125558] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.134373] zbud: loaded [ 3.137116] *** VALIDATE nfs *** [ 3.137981] *** VALIDATE nfs4 *** [ 3.139113] pstore: using deflate compression [ 3.142119] Platform Keyring initialized [ 3.274576] NET: Registered protocol family 38 [ 3.276242] Key type asymmetric registered [ 3.277605] Asymmetric key parser 'x509' registered [ 3.279355] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.282203] io scheduler mq-deadline registered [ 3.283754] io scheduler kyber registered [ 3.285407] io scheduler bfq registered [ 3.287139] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.289989] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.292691] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.295716] ACPI: Power Button [PWRF] [ 3.301525] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.313878] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.343489] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.381911] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.413391] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.418088] Non-volatile memory driver v1.3 [ 3.418906] Linux agpgart interface v0.103 [ 3.452529] virtio_blk virtio1: [vda] 134920 512-byte logical blocks (69.1 MB/65.9 MiB) [ 3.455232] vda: detected capacity change from 0 to 69079040 [ 3.487608] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.490433] vdb: detected capacity change from 0 to 1073741824 [ 3.524726] libphy: Fixed MDIO Bus: probed [ 3.531412] usbcore: registered new interface driver usbserial_generic [ 3.533653] usbserial: USB Serial support registered for generic [ 3.535672] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.540419] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.542340] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.545150] mousedev: PS/2 mouse device common for all mice [ 3.548587] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.549070] rtc_cmos 00:05: RTC can wake from S4 [ 3.558619] rtc_cmos 00:05: registered as rtc0 [ 3.562892] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.568544] intel_pstate: CPU model not supported [ 3.571169] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.573774] hid: raw HID events driver (C) Jiri Kosina [ 3.578695] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.580287] usbcore: registered new interface driver usbhid [ 3.580291] usbhid: USB HID core driver [ 3.580419] drop_monitor: Initializing network drop monitor service [ 3.580550] Initializing XFRM netlink socket [ 3.581136] NET: Registered protocol family 10 [ 3.595055] Segment Routing with IPv6 [ 3.596534] NET: Registered protocol family 17 [ 3.598545] mpls_gso: MPLS GSO support [ 3.604085] RAS: Correctable Errors collector initialized. [ 3.605804] AVX version of gcm_enc/dec engaged. [ 3.607541] AES CTR mode by8 optimization enabled [ 3.704974] sched_clock: Marking stable (3704951632, 0)->(4671397645, -966446013) [ 3.709451] registered taskstats version 1 [ 3.712880] Loading compiled-in X.509 certificates [ 3.715306] zswap: loaded using pool lzo/zbud [ 3.749697] Key type big_key registered [ 3.767395] Key type encrypted registered [ 3.769172] ima: No TPM chip found, activating TPM-bypass! [ 3.771846] ima: Allocated hash algorithm: sha1 [ 3.773861] ima: No architecture policies found [ 3.775913] evm: Initialising EVM extended attributes: [ 3.778207] evm: security.selinux [ 3.779527] evm: security.ima [ 3.780724] evm: security.capability [ 3.782353] evm: HMAC attrs: 0x1 [ 3.785257] rtc_cmos 00:05: setting system clock to 2026-05-13 06:01:53 UTC (1778652113) [ 3.793233] debug: unmapping init [mem 0xffffffffbdc03000-0xffffffffbddfffff] [ 3.796673] debug: unmapping init [mem 0xffffffffbc982000-0xffffffffbcc58fff] [ 3.809351] Write protecting the kernel read-only data: 28672k [ 3.812901] debug: unmapping init [mem 0xffffffffbb003000-0xffffffffbb1fffff] [ 3.815530] debug: unmapping init [mem 0xffffffffbb914000-0xffffffffbb9fffff] [ 3.845131] 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.850589] systemd[1]: Detected virtualization kvm. [ 3.851780] systemd[1]: Detected architecture x86-64. [ 3.853174] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.889536] systemd[1]: No hostname configured. [ 3.891383] systemd[1]: Set hostname to . [ 3.893756] random: systemd: uninitialized urandom read (16 bytes read) [ 3.896460] systemd[1]: Initializing machine ID from random generator. [ 4.165614] random: ln: uninitialized urandom read (6 bytes read) [ 4.427979] random: systemd: uninitialized urandom read (16 bytes read) [ 4.432915] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 4.449579] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 4.464798] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Sockets. Starting Journal Service... Starting Setup Virtual Console... [ OK ] Reached target Paths. Starting Create Volatile Files and Directories... Starting Apply Kernel Variables... [ OK ] Reached target Swap. [ OK ] Started Memstrack Anylazing Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 6.251788] device-mapper: uevent: version 1.0.3 [ 6.254227] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 7.607347] virtio_net virtio0 ens2: renamed from eth0 [ 7.666627] random: fast init done [ 8.131836] scsi host0: ata_piix [ 8.186348] scsi host1: ata_piix [ 8.187811] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 8.190331] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 15.930074] random: crng init done [ 15.931499] random: 7 urandom warning(s) missed due to ratelimiting [ 18.409937] dracut-initqueue[584]: 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.267560] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Slices. [ 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.487889] printk: systemd: 26 output lines suppressed due to ratelimiting [ 22.931246] SELinux: Disabled at runtime. [ 22.996394] 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) [ 23.005277] systemd[1]: Detected virtualization kvm. [ 23.014307] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 24.641875] systemd[1]: initrd-switch-root.service: Succeeded. [ 24.663844] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 24.693919] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 24.736765] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 24.740808] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 24.755802] systemd[1]: Starting Journal Service... Starting Journal Service... [ 24.770769] systemd[1]: Stopped target Switch Root. [ OK ] Stopped target Switch Root. Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Control Socket. [ OK ] Listening on Process Core Dump Socket. Starting Remount Root and Kernel File Systems... [ OK ] Created slice User and Session Slice. [ 24.913206] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Stopped target Initrd Root File System. Mounting Huge Pages File System... Mounting Kernel Debug File System... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Reached target rpc_pipefs.target. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice system-sshd\x2dkeygen.slice. Starting Apply Kernel Variables... [ OK ] Reached target Slices. [ OK ] Created slice system-getty.slice. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting POSIX Message Queue File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Stopped target Initrd File Systems. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted POSIX Message Queue File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started udev Coldplug all Devices. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 26.497736] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 27.643635] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 27.689845] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 28.166634] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 28.324127] EDAC sbridge: Ver: 1.1.2 [ 31.781024] Key type dns_resolver registered [* ] A start job is running for Configur…-only root support (8s / no limit)[ 33.149302] NFS: Registering the id_resolver key type [ 33.151618] Key type id_resolver registered [ 33.153548] 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 Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Reached target sshd-keygen.target. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Restore /run/initramfs on shutdown... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ 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 oleg154-client login: [ 50.559359] hrtimer: interrupt took 2693703 ns [ 113.963874] libcfs: loading out-of-tree module taints kernel. [ 114.104430] Key type ._llcrypt registered [ 114.106043] Key type .llcrypt registered [ 114.557283] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 114.568673] alg: No test for adler32 (adler32-zlib) [ 116.076757] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 117.196398] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 119.183677] Key type lgssc registered [ 121.431724] Lustre: Echo OBD driver; http://www.lustre.org/ [ 276.058745] Lustre: Mounted lustre-client [ 281.420030] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 293.723994] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing check_logdir /tmp/testlogs/ [ 298.331374] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing yml_node [ 301.536894] Lustre: lustre-OST0000-osc-ffff8ee6e0207800: disconnect after 23s idle [ 302.148960] Lustre: DEBUG MARKER: Client: 2.17.53.3 [ 304.876770] Lustre: DEBUG MARKER: MDS: 2.17.53.3 [ 307.591749] Lustre: DEBUG MARKER: OSS: 2.17.53.3 [ 309.375337] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed May 13 02:06:57 EDT 2026 [ 327.476412] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 328.884960] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 331.777478] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 342.155291] Lustre: Unmounted lustre-client [ 456.452527] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 460.529977] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 481.079287] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 514.400151] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 02:10:22 (1778652622) [ 516.472271] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 518.041759] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 02:10:26 (1778652626) [ 542.881641] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 546.152250] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 559.969701] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 570.910590] Lustre: Mounted lustre-client [ 574.703741] LustreError: 14419:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d8781000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 574.815536] Lustre: Unmounted lustre-client [ 599.261458] Key type lgssc unregistered [ 599.472785] LNet: 14827:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 599.476647] LNetError: 14827:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 599.498587] LNet: Removed LNI 192.168.201.54@tcp [ 600.217189] Key type .llcrypt unregistered [ 600.219341] Key type ._llcrypt unregistered [ 610.380209] Key type ._llcrypt registered [ 610.381516] Key type .llcrypt registered [ 611.325650] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 02:12:00 (1778652720) [ 612.342245] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 612.351130] alg: No test for adler32 (adler32-zlib) [ 613.339540] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 613.502056] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 615.095369] Key type lgssc registered [ 615.736845] Lustre: Echo OBD driver; http://www.lustre.org/ [ 665.419731] Lustre: Mounted lustre-client [ 750.778405] LustreError: 18139:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d63dd000: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 750.803542] Lustre: Unmounted lustre-client [ 776.817441] Key type lgssc unregistered [ 776.978955] LNet: 18605:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 776.983800] LNetError: 18605:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 777.003092] LNet: Removed LNI 192.168.201.54@tcp [ 777.401125] Key type .llcrypt unregistered [ 777.402651] Key type ._llcrypt unregistered [ 783.436562] Key type ._llcrypt registered [ 783.438502] Key type .llcrypt registered [ 784.282672] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 02:14:53 (1778652893) [ 785.856527] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 785.882760] alg: No test for adler32 (adler32-zlib) [ 786.840725] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 787.012523] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 788.631167] Key type lgssc registered [ 789.329456] Lustre: Echo OBD driver; http://www.lustre.org/ [ 817.253665] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 819.645569] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 830.436550] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 832.768925] Lustre: Mounted lustre-client [ 842.446753] LustreError: 21704:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c6521000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 842.491693] Lustre: Unmounted lustre-client [ 872.315676] Key type lgssc unregistered [ 872.653971] LNet: 22108:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 872.657964] LNetError: 22108:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 872.672758] LNet: Removed LNI 192.168.201.54@tcp [ 873.386146] Key type .llcrypt unregistered [ 873.390234] Key type ._llcrypt unregistered [ 885.485780] Key type ._llcrypt registered [ 885.487480] Key type .llcrypt registered [ 886.839840] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 02:16:34 (1778652994) [ 889.185277] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 889.201124] alg: No test for adler32 (adler32-zlib) [ 890.248875] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 890.518962] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 892.194860] Key type lgssc registered [ 893.434557] Lustre: Echo OBD driver; http://www.lustre.org/ [ 929.476175] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 934.588786] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 967.805681] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 970.547640] Lustre: Mounted lustre-client [ 979.634274] LustreError: 24811:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d4c9e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 979.758599] Lustre: Unmounted lustre-client [ 1009.925833] Key type lgssc unregistered [ 1010.287161] LNet: 25215:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1010.300374] LNetError: 25215:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1010.349236] LNet: Removed LNI 192.168.201.54@tcp [ 1011.097618] Key type .llcrypt unregistered [ 1011.101772] Key type ._llcrypt unregistered [ 1026.963195] Key type ._llcrypt registered [ 1026.965756] Key type .llcrypt registered [ 1028.552482] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 02:18:56 (1778653136) [ 1030.975655] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1031.161398] alg: No test for adler32 (adler32-zlib) [ 1032.322941] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 1032.592601] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 1034.383184] Key type lgssc registered [ 1035.927517] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1085.209954] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1089.257709] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1109.974670] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1112.692499] Lustre: Mounted lustre-client [ 1117.673950] Lustre: lustre-MDT0000-mdc-ffff8ee6d3511800: Connection to lustre-MDT0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1133.038486] Lustre: lustre-MDT0001-mdc-ffff8ee6d3511800: Connection to lustre-MDT0001 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1136.726480] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1144.289688] Lustre: 26174:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778653237/real 1778653237] req@00000000c4e217dd x1865052997031936/t0(0) o400->MGC192.168.201.154@tcp@192.168.201.154@tcp:26/25 lens 224/224 e 0 to 1 dl 1778653253 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1144.309608] LustreError: MGC192.168.201.154@tcp: Connection to MGS (at 192.168.201.154@tcp) was lost; in progress operations using this service will fail [ 1147.121480] Lustre: Unmounted lustre-client [ 1167.621905] Key type lgssc unregistered [ 1167.868100] LNet: 28780:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1167.880381] LNetError: 28780:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1167.903906] LNet: Removed LNI 192.168.201.54@tcp [ 1168.649405] Key type .llcrypt unregistered [ 1168.663910] Key type ._llcrypt unregistered [ 1188.485401] Key type ._llcrypt registered [ 1188.494310] Key type .llcrypt registered [ 1190.233900] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 02:21:38 (1778653298) [ 1193.091601] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1193.248088] alg: No test for adler32 (adler32-zlib) [ 1194.620537] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 1194.993605] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 1196.791642] Key type lgssc registered [ 1198.378295] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1255.528439] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1260.476652] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1288.006270] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1291.254845] Lustre: Mounted lustre-client [ 1301.488862] Lustre: lustre-OST0000-osc-ffff8ee6c723f000: Connection to lustre-OST0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1305.718679] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1316.133944] Lustre: Unmounted lustre-client [ 1351.653240] Key type lgssc unregistered [ 1351.944472] LNet: 32314:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1351.950099] LNetError: 32314:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1351.971661] LNet: Removed LNI 192.168.201.54@tcp [ 1352.663785] Key type .llcrypt unregistered [ 1352.671264] Key type ._llcrypt unregistered [ 1367.563280] Key type ._llcrypt registered [ 1367.564828] Key type .llcrypt registered [ 1368.898736] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 02:24:37 (1778653477) [ 1371.174793] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1371.261923] alg: No test for adler32 (adler32-zlib) [ 1372.441115] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 1372.650640] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 1374.335198] Key type lgssc registered [ 1375.585202] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1422.231155] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1426.053499] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1445.093842] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1447.743426] Lustre: Mounted lustre-client [ 1451.556472] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1454.727894] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1466.477281] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-05-13 2h26m14s [ 1468.614604] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1473.518592] Lustre: lustre-MDT0000-mdc-ffff8ee6c6fac000: Connection to lustre-MDT0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1478.473355] LustreError: 36011:0:(lmv_obd.c:1449:lmv_statfs()) lustre-MDT0000-mdc-ffff8ee6c6fac000: can't stat MDS #0: rc = -19 [ 1479.974318] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1490.918155] LustreError: MGC192.168.201.154@tcp: Connection to MGS (at 192.168.201.154@tcp) was lost; in progress operations using this service will fail [ 1490.939647] Lustre: Evicted from MGS (at 192.168.201.154@tcp) after server handle changed from 0xd3fc0f1130f29c59 to 0xd3fc0f1130f29f1c [ 1490.947918] Lustre: MGC192.168.201.154@tcp: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [ 1492.019330] LustreError: lustre-MDT0000-mdc-ffff8ee6c6fac000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1492.046076] Lustre: lustre-MDT0000-mdc-ffff8ee6c6fac000: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [ 1494.083678] Lustre: DEBUG MARKER: Wait for df (36011) ... [ 1495.399934] Lustre: DEBUG MARKER: done [ 1497.605446] LustreError: 36623:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c6fac000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1497.676108] Lustre: Unmounted lustre-client [ 1525.594555] Key type lgssc unregistered [ 1525.922733] LNet: 37025:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1525.930150] LNetError: 37025:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1525.943115] LNet: Removed LNI 192.168.201.54@tcp [ 1526.755645] Key type .llcrypt unregistered [ 1526.757754] Key type ._llcrypt unregistered [ 1558.624059] Key type ._llcrypt registered [ 1558.625681] Key type .llcrypt registered [ 1559.654793] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 02:27:48 (1778653668) [ 1562.551403] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1562.585867] alg: No test for adler32 (adler32-zlib) [ 1563.574769] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 1563.784930] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 1565.463143] Key type lgssc registered [ 1566.770342] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1609.409926] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1613.063103] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1631.271646] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1633.897785] Lustre: Mounted lustre-client [ 1637.778169] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-05-13 2h29m06s [ 1639.011381] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1645.482904] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1647.516525] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1668.063197] Lustre: 41084:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778653757/real 1778653757] req@00000000fef9b9c2 x1865053553826560/t0(0) o101->lustre-MDT0000-mdc-ffff8ee6d32bf800@192.168.201.154@tcp:12/10 lens 576/1152 e 0 to 1 dl 1778653777 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1668.086415] Lustre: lustre-MDT0000-mdc-ffff8ee6d32bf800: Connection to lustre-MDT0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1668.132954] Lustre: lustre-MDT0000-mdc-ffff8ee6d32bf800: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [ 1689.432407] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1692.183798] Lustre: DEBUG MARKER: done [ 1695.667269] LustreError: 41557:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d32bf800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1695.731377] Lustre: Unmounted lustre-client [ 1725.751138] Key type lgssc unregistered [ 1726.085769] LNet: 41960:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1726.094886] LNetError: 41960:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1726.118311] LNet: Removed LNI 192.168.201.54@tcp [ 1726.802720] Key type .llcrypt unregistered [ 1726.805136] Key type ._llcrypt unregistered [ 1755.501236] Key type ._llcrypt registered [ 1755.506194] Key type .llcrypt registered [ 1756.454573] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 02:31:05 (1778653865) [ 1758.127887] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1759.693965] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 02:31:08 (1778653868) [ 1763.180080] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1763.273316] alg: No test for adler32 (adler32-zlib) [ 1764.326239] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 1764.569670] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 1766.287657] Key type lgssc registered [ 1767.563745] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1795.305949] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 02:31:43 (1778653903) [ 1824.659294] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1827.640839] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1845.746677] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1848.508822] Lustre: Mounted lustre-client [ 1851.904418] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1854.671901] LustreError: 46300:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6e0823000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1854.769792] Lustre: Unmounted lustre-client [ 1865.190807] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1904.476555] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1907.606279] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1908.069226] Lustre: Mounted lustre-client [ 1911.106900] LustreError: 47552:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c7239000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1911.185921] Lustre: Unmounted lustre-client [ 1961.578176] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1964.219520] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1964.600982] Lustre: Mounted lustre-client [ 1967.245901] LustreError: 48667:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d63da800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1967.312606] Lustre: Unmounted lustre-client [ 1981.236059] Lustre: DEBUG MARKER: files compared the same [ 1999.412984] Key type lgssc unregistered [ 1999.609705] LNet: 49371:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1999.616804] LNetError: 49371:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1999.636179] LNet: Removed LNI 192.168.201.54@tcp [ 1999.994527] Key type .llcrypt unregistered [ 1999.995969] Key type ._llcrypt unregistered [ 2009.698334] Key type ._llcrypt registered [ 2009.700809] Key type .llcrypt registered [ 2010.452610] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 02:35:19 (1778654119) [ 2011.733210] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2011.756740] alg: No test for adler32 (adler32-zlib) [ 2012.681575] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 2012.814502] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 2014.431357] Key type lgssc registered [ 2015.088069] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2054.023724] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2056.940752] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2072.064079] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2082.977379] Lustre: Mounted lustre-client [ 2086.962903] LustreError: 52457:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c6fad000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2087.101574] Lustre: Unmounted lustre-client [ 2144.160514] Key type lgssc unregistered [ 2144.592485] LNet: 52864:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2144.612065] LNetError: 52864:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2144.647739] LNet: Removed LNI 192.168.201.54@tcp [ 2145.854329] Key type .llcrypt unregistered [ 2145.865170] Key type ._llcrypt unregistered [ 2168.878426] Key type ._llcrypt registered [ 2168.880583] Key type .llcrypt registered [ 2170.284498] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 02:37:58 (1778654278) [ 2173.353319] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2173.518198] alg: No test for adler32 (adler32-zlib) [ 2174.687835] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 2175.010747] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 2176.707834] Key type lgssc registered [ 2177.961091] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2263.212362] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2298.038252] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2302.536155] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2335.417815] Key type lgssc unregistered [ 2335.720980] LNet: 56263:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2335.728119] LNetError: 56263:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2335.766663] LNet: Removed LNI 192.168.201.54@tcp [ 2336.520746] Key type .llcrypt unregistered [ 2336.522217] Key type ._llcrypt unregistered [ 2355.050835] Key type ._llcrypt registered [ 2355.054225] Key type .llcrypt registered [ 2356.576880] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 02:41:04 (1778654464) [ 2361.246165] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2361.348339] alg: No test for adler32 (adler32-zlib) [ 2362.521242] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 2362.873990] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 2364.703195] Key type lgssc registered [ 2366.246485] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2456.022709] Lustre: Mounted lustre-client [ 2464.144044] LustreError: 58752:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c68af800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2464.299289] Lustre: Unmounted lustre-client [ 2508.275384] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 02:43:35 (1778654615) [ 2645.316566] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2664.515845] Lustre: Mounted lustre-client [ 2671.989048] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2672.001834] LustreError: 62708:0:(file.c:252:ll_close_inode_openhandle()) lustre-clilmv-ffff8ee6d1c30800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2672.021729] Lustre: 57249:0:(llite_lib.c:4187:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.201.154@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2682.333350] Lustre: Unmounted lustre-client [ 2723.724424] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 02:47:11 (1778654831) [ 2737.929524] Key type lgssc unregistered [ 2738.297944] LNet: 63922:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2738.306938] LNetError: 63922:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2738.350918] LNet: Removed LNI 192.168.201.54@tcp [ 2739.379667] Key type .llcrypt unregistered [ 2739.386335] Key type ._llcrypt unregistered [ 2753.332946] Key type ._llcrypt registered [ 2753.336246] Key type .llcrypt registered [ 2753.765087] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2753.786239] alg: No test for adler32 (adler32-zlib) [ 2754.749501] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 2754.939180] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 2756.615633] Key type lgssc registered [ 2757.928152] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2808.213472] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2812.549691] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2832.063473] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2833.883881] Lustre: Mounted lustre-client [ 2838.450169] LustreError: 66443:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c68ae800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2838.600108] Lustre: Unmounted lustre-client [ 2870.490258] Key type lgssc unregistered [ 2870.704425] LNet: 66845:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2870.713230] LNetError: 66845:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2870.729824] LNet: Removed LNI 192.168.201.54@tcp [ 2871.678545] Key type .llcrypt unregistered [ 2871.684466] Key type ._llcrypt unregistered [ 2883.797818] Key type ._llcrypt registered [ 2883.802155] Key type .llcrypt registered [ 2884.413988] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2884.433514] alg: No test for adler32 (adler32-zlib) [ 2885.444728] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 2885.761685] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 2887.487267] Key type lgssc registered [ 2888.951243] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3009.308980] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3013.792788] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3044.305250] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3050.566468] Lustre: Mounted lustre-client [ 3053.961675] LustreError: 69785:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c7606000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3054.114949] Lustre: Unmounted lustre-client [ 3086.672238] Key type lgssc unregistered [ 3087.112109] LNet: 70187:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3087.120598] LNetError: 70187:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3088.168204] LNet: Removed LNI 192.168.201.54@tcp [ 3089.569384] Key type .llcrypt unregistered [ 3089.571562] Key type ._llcrypt unregistered [ 3109.847728] Key type ._llcrypt registered [ 3109.849884] Key type .llcrypt registered [ 3111.504910] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 02:53:39 (1778655219) [ 3113.985032] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3114.089067] alg: No test for adler32 (adler32-zlib) [ 3115.325568] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 3115.616302] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 3117.711621] Key type lgssc registered [ 3119.377773] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3173.716801] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3178.988828] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3199.486729] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3202.299565] Lustre: Mounted lustre-client [ 3208.583568] LustreError: 73309:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d1c30000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3208.727328] Lustre: Unmounted lustre-client [ 3209.346619] Lustre: Mounted lustre-client [ 3213.212963] LustreError: 73381:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c5827000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3213.315199] Lustre: Unmounted lustre-client [ 3242.510512] Key type lgssc unregistered [ 3242.743617] LNet: 73784:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3242.749317] LNetError: 73784:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3242.774965] LNet: Removed LNI 192.168.201.54@tcp [ 3243.597996] Key type .llcrypt unregistered [ 3243.605834] Key type ._llcrypt unregistered [ 3258.179964] Key type ._llcrypt registered [ 3258.184463] Key type .llcrypt registered [ 3258.853143] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3258.881427] alg: No test for adler32 (adler32-zlib) [ 3259.963133] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 3260.188841] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 3261.871182] Key type lgssc registered [ 3263.611390] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3321.941210] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3325.711159] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3352.057832] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3355.094286] Lustre: Mounted lustre-client [ 3361.671262] LustreError: 76324:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d3599800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3361.774268] Lustre: Unmounted lustre-client [ 3402.068587] Key type lgssc unregistered [ 3402.450952] LNet: 76730:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3402.455547] LNetError: 76730:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3402.491598] LNet: Removed LNI 192.168.201.54@tcp [ 3403.842133] Key type .llcrypt unregistered [ 3403.850166] Key type ._llcrypt unregistered [ 3423.439510] Key type ._llcrypt registered [ 3423.443111] Key type .llcrypt registered [ 3424.915262] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 02:58:52 (1778655532) [ 3428.173942] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3428.206370] alg: No test for adler32 (adler32-zlib) [ 3429.592667] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 3429.933207] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 3431.695237] Key type lgssc registered [ 3433.084828] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3493.457522] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3498.752344] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3525.454714] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3527.844088] Lustre: Mounted lustre-client [ 3542.154398] Lustre: lustre: nosquash_nids is cleared [ 3542.185046] Lustre: lustre: root_squash is set to 500:500 [ 3548.091940] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.201.54@tcp 192.168.0.[2,10]@tcp [ 3557.649912] Lustre: lustre: nosquash_nids set to 192.168.201.54/24@tcp [ 3562.196119] LustreError: 80151:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c6f87000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3562.300407] Lustre: Unmounted lustre-client [ 3607.392272] Key type lgssc unregistered [ 3607.696266] LNet: 80557:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3607.703258] LNetError: 80557:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3607.725073] LNet: Removed LNI 192.168.201.54@tcp [ 3608.436817] Key type .llcrypt unregistered [ 3608.439223] Key type ._llcrypt unregistered [ 3624.246788] Key type ._llcrypt registered [ 3624.248263] Key type .llcrypt registered [ 3625.328188] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 03:02:13 (1778655733) [ 3627.485308] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3629.082305] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 03:02:17 (1778655737) [ 3631.212578] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3631.460418] alg: No test for adler32 (adler32-zlib) [ 3632.728841] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 3632.934281] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 3634.607190] Key type lgssc registered [ 3635.858860] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3682.223690] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3686.489432] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3707.920500] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3709.800989] Lustre: lustre: root_squash is set to 500:500 [ 3709.861444] Lustre: lustre: nosquash_nids set to 192.168.201.54/24@tcp [ 3710.924864] Lustre: Mounted lustre-client [ 3718.940439] LustreError: 84023:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6e0823800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3719.057429] Lustre: Unmounted lustre-client [ 3748.043285] Key type lgssc unregistered [ 3748.327641] LNet: 84426:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3748.334387] LNetError: 84426:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3748.358606] LNet: Removed LNI 192.168.201.54@tcp [ 3749.587604] Key type .llcrypt unregistered [ 3749.597154] Key type ._llcrypt unregistered [ 3772.428334] Key type ._llcrypt registered [ 3772.429754] Key type .llcrypt registered [ 3774.422561] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3777.226086] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 03:04:44 (1778655884) [ 3797.481306] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3797.497090] alg: No test for adler32 (adler32-zlib) [ 3798.644900] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 3798.874468] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 3800.554596] Key type lgssc registered [ 3801.769546] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3887.488638] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3891.116779] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3911.230962] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3979.568439] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3984.793508] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4015.378382] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4032.575103] Lustre: Mounted lustre-client [ 4071.763787] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8ee6c30a4800.ost_server_uuid 50 [ 4075.121862] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8ee6c30a4800.ost_server_uuid in IDLE state after 0 sec [ 4076.253423] Lustre: Mounted lustre-client [ 4083.076788] LustreError: 91322:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c723d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4083.474223] Lustre: Unmounted lustre-client [ 4087.617304] LustreError: 91342:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c30a4800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4087.631634] LustreError: 91342:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 4087.767064] Lustre: Unmounted lustre-client [ 4142.004587] Key type lgssc unregistered [ 4142.411285] LNet: 91899:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4142.419445] LNetError: 91899:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4142.451947] LNet: Removed LNI 192.168.201.54@tcp [ 4143.249384] Key type .llcrypt unregistered [ 4143.265824] Key type ._llcrypt unregistered [ 4175.691330] Key type ._llcrypt registered [ 4175.693669] Key type .llcrypt registered [ 4177.478532] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 03:11:25 (1778656285) [ 4197.073069] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4197.134350] alg: No test for adler32 (adler32-zlib) [ 4198.714650] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 4199.175876] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 4201.081119] Key type lgssc registered [ 4202.529391] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4283.758143] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4288.622784] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4313.375363] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4316.369853] Lustre: Mounted lustre-client [ 4338.143206] Lustre: 93264:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778656431/real 1778656431] req@000000000806275c x1865056316822784/t0(0) o400->lustre-OST0000-osc-ffff8ee6d3511800@192.168.201.154@tcp:28/4 lens 224/224 e 0 to 1 dl 1778656447 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4338.202615] Lustre: lustre-OST0000-osc-ffff8ee6d3511800: Connection to lustre-OST0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4342.368455] Lustre: 93264:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778656436/real 1778656436] req@00000000226b9ba8 x1865056316823296/t0(0) o400->lustre-OST0000-osc-ffff8ee6d3511800@192.168.201.154@tcp:28/4 lens 224/224 e 0 to 1 dl 1778656452 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4347.463875] Lustre: lustre-OST0000-osc-ffff8ee6d3511800: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [ 4347.532209] Lustre: 93264:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778656441/real 1778656441] req@00000000ae076a80 x1865056316823808/t0(0) o400->lustre-OST0000-osc-ffff8ee6d3511800@192.168.201.154@tcp:28/4 lens 224/224 e 0 to 1 dl 1778656457 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4352.502698] Lustre: lustre-MDT0000-mdc-ffff8ee6d3511800: Connection to lustre-MDT0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4353.503225] Lustre: 93263:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778656446/real 1778656446] req@000000003bacb4a6 x1865056316824320/t0(0) o400->lustre-OST0000-osc-ffff8ee6d3511800@192.168.201.154@tcp:28/4 lens 224/224 e 0 to 1 dl 1778656462 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4368.863283] Lustre: 93264:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778656462/real 1778656462] req@000000003c09fda4 x1865056316826624/t0(0) o400->MGC192.168.201.154@tcp@192.168.201.154@tcp:26/25 lens 224/224 e 0 to 1 dl 1778656478 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4368.885794] LustreError: MGC192.168.201.154@tcp: Connection to MGS (at 192.168.201.154@tcp) was lost; in progress operations using this service will fail [ 4379.058052] Lustre: Evicted from MGS (at 192.168.201.154@tcp) after server handle changed from 0xfdd8630e6b595367 to 0xfdd8630e6b5954fd [ 4379.128040] Lustre: MGC192.168.201.154@tcp: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [ 4389.145621] Lustre: lustre-MDT0000-mdc-ffff8ee6d3511800: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [ 4396.827840] LustreError: 97089:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d3511800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4396.994746] Lustre: Unmounted lustre-client [ 4428.415393] Key type lgssc unregistered [ 4428.768151] LNet: 97493:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4428.791727] LNetError: 97493:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4428.818716] LNet: Removed LNI 192.168.201.54@tcp [ 4429.664575] Key type .llcrypt unregistered [ 4429.667792] Key type ._llcrypt unregistered [ 4448.120679] Key type ._llcrypt registered [ 4448.122753] Key type .llcrypt registered [ 4449.909395] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 03:15:57 (1778656557) [ 4465.334106] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4465.451369] alg: No test for adler32 (adler32-zlib) [ 4466.635386] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 4466.986272] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 4468.663217] Key type lgssc registered [ 4470.211292] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4516.526469] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4625.436363] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4631.413939] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4659.443518] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4662.208716] Lustre: Mounted lustre-client [ 4664.561843] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4667.082761] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 03:19:34 (1778656774) [ 4963.725293] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4974.108724] Lustre: Unmounted lustre-client [ 5112.401271] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5119.010141] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5144.220812] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5198.325782] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 03:28:25 (1778657305) [ 5323.475759] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5328.867528] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5354.297312] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5355.071866] Lustre: Mounted lustre-client [ 5360.191688] LustreError: 115730:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c786a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5360.283476] Lustre: Unmounted lustre-client [ 5397.976423] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 03:31:45 (1778657505) [ 5503.630360] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5508.315273] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5533.456636] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5534.451862] Lustre: Mounted lustre-client [ 5540.030548] LustreError: 119783:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c7878800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5540.189071] Lustre: Unmounted lustre-client [ 5572.622300] Key type lgssc unregistered [ 5572.941865] LNet: 120187:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5572.955971] LNetError: 120187:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5572.990564] LNet: Removed LNI 192.168.201.54@tcp [ 5574.032979] Key type .llcrypt unregistered [ 5574.038437] Key type ._llcrypt unregistered [ 5593.381895] Key type ._llcrypt registered [ 5593.383227] Key type .llcrypt registered [ 5594.691489] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 03:35:03 (1778657703) [ 5598.787891] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5598.833081] alg: No test for adler32 (adler32-zlib) [ 5600.171322] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 5600.528963] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 5602.327220] Key type lgssc registered [ 5603.824454] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5662.397807] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5667.301760] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5689.937402] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5692.962709] Lustre: Mounted lustre-client [ 5710.393804] LustreError: 123289:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d0978000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5710.501148] Lustre: Unmounted lustre-client [ 5742.627902] Key type lgssc unregistered [ 5742.935483] LNet: 123692:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5742.947590] LNetError: 123692:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5742.972134] LNet: Removed LNI 192.168.201.54@tcp [ 5744.263863] Key type .llcrypt unregistered [ 5744.272163] Key type ._llcrypt unregistered [ 5765.277626] Key type ._llcrypt registered [ 5765.280673] Key type .llcrypt registered [ 5767.359463] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 03:37:54 (1778657874) [ 5770.489685] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5770.593449] alg: No test for adler32 (adler32-zlib) [ 5771.865988] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 5772.221988] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 5773.911515] Key type lgssc registered [ 5775.271886] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5831.704457] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5836.239189] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5858.926960] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5861.763073] Lustre: Mounted lustre-client [ 5877.815607] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8ee6d0979000.ost_server_uuid 50 [ 5887.456940] Lustre: 124654:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778657981/real 1778657981] req@00000000c3968c9b x1865057966233472/t0(0) o400->lustre-OST0000-osc-ffff8ee6d0979000@192.168.201.154@tcp:28/4 lens 224/224 e 0 to 1 dl 1778657997 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5887.501514] Lustre: lustre-OST0000-osc-ffff8ee6d0979000: Connection to lustre-OST0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5889.633803] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5892.582492] Lustre: 124655:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778657986/real 1778657986] req@00000000a7913478 x1865057966233984/t0(0) o400->lustre-OST0000-osc-ffff8ee6d0979000@192.168.201.154@tcp:28/4 lens 224/224 e 0 to 1 dl 1778658002 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5898.719193] Lustre: 124654:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778657992/real 1778657992] req@00000000950c8992 x1865057966234496/t0(0) o400->lustre-OST0000-osc-ffff8ee6d0979000@192.168.201.154@tcp:28/4 lens 224/224 e 0 to 1 dl 1778658008 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 5902.436408] LustreError: 127297:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d0979000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5902.517391] Lustre: Unmounted lustre-client [ 5927.643987] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 03:40:35 (1778658035) [ 5965.353199] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5970.177555] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5990.409501] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6016.377520] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6017.436252] Lustre: Mounted lustre-client [ 6022.659858] Lustre: lustre-OST0000-osc-ffff8ee6c7725000: Connection to lustre-OST0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6061.027790] LustreError: 129952:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c7725000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6061.117663] Lustre: Unmounted lustre-client [ 6125.763479] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 03:43:53 (1778658233) [ 6161.245757] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6165.683970] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6186.753993] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6208.493995] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6209.541211] Lustre: Mounted lustre-client [ 6214.636692] Lustre: lustre-OST0000-osc-ffff8ee6c7506000: Connection to lustre-OST0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6241.081043] LustreError: 132707:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c7506000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6241.101605] LustreError: 132707:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 6241.214304] Lustre: Unmounted lustre-client [ 6302.417191] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 03:46:50 (1778658410) [ 6404.592865] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6408.636114] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6433.589029] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6499.998305] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6503.850248] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6524.435275] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6557.919952] Lustre: Mounted lustre-client [ 6600.134168] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6605.610728] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 6608.186779] LustreError: 139333:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d32b9800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6608.192325] LustreError: 139333:0:(lov_obd.c:792:lov_cleanup()) Skipped 1 previous similar message [ 6608.283702] Lustre: Unmounted lustre-client [ 6641.823142] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 03:52:30 (1778658750) [ 6672.307655] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6675.899707] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6696.763648] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6733.871606] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6764.719204] Lustre: Mounted lustre-client [ 6807.431516] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6809.779996] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6822.406385] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6832.745124] Lustre: Unmounted lustre-client [ 6886.148908] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 03:56:33 (1778658993) [ 6917.841533] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6921.957813] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6940.541900] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6941.084529] Lustre: Mounted lustre-client [ 6963.361540] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 6965.356663] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6979.622552] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8ee6d8781000.ost_server_uuid 50 [ 6981.204802] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8ee6d8781000.ost_server_uuid in IDLE state after 0 sec [ 6985.460993] LustreError: 146335:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d8781000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6985.581965] Lustre: Unmounted lustre-client [ 6985.947322] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6985.956128] Lustre: Skipped 3 previous similar messages [ 6986.070249] Lustre: Mounted lustre-client [ 6987.194093] LustreError: 146390:0:(sec.c:413:import_sec_validate_get()) import 0000000046e4016e (NEW) with no sec [ 7055.087391] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 03:59:23 (1778659163) [ 7085.614501] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7090.317560] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7110.459916] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7135.910506] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7136.345085] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7136.607615] Lustre: Mounted lustre-client [ 7151.082031] LustreError: 149231:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d3512800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7151.097084] LustreError: 149231:0:(lov_obd.c:792:lov_cleanup()) Skipped 2 previous similar messages [ 7151.250224] Lustre: Unmounted lustre-client [ 7151.253906] Lustre: Skipped 1 previous similar message [ 7192.641115] Key type lgssc unregistered [ 7192.954490] LNet: 149692:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7192.967636] LNetError: 149692:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7192.984755] LNet: Removed LNI 192.168.201.54@tcp [ 7193.652787] Key type .llcrypt unregistered [ 7193.660187] Key type ._llcrypt unregistered [ 7211.564231] Key type ._llcrypt registered [ 7211.567978] Key type .llcrypt registered [ 7212.883286] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 04:02:01 (1778659321) [ 7214.102759] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7214.219894] alg: No test for adler32 (adler32-zlib) [ 7215.340641] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 7215.600802] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 7217.303214] Key type lgssc registered [ 7218.879597] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7270.871667] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7274.837854] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7295.734569] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7315.510660] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7317.194171] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7318.386181] Lustre: Mounted lustre-client [ 7325.205938] LustreError: lustre-MDT0001-mdc-ffff8ee6c723d000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7325.233849] Lustre: lustre-MDT0001-mdc-ffff8ee6c723d000: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [ 7329.931618] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7331.741284] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7351.806427] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7356.376825] LustreError: 153908:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c723d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7356.454306] Lustre: Unmounted lustre-client [ 7378.793555] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 04:04:46 (1778659486) [ 7488.893338] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7493.357245] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7516.193865] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7516.799731] Lustre: Mounted lustre-client [ 7540.510956] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7542.495834] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7547.882674] Lustre: lustre-OST0001-osc-ffff8ee6d0978800: Connection to lustre-OST0001 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7555.793904] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7566.133379] Lustre: Unmounted lustre-client [ 7604.298451] Key type lgssc unregistered [ 7604.548517] LNet: 159040:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7604.556498] LNetError: 159040:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7604.579492] LNet: Removed LNI 192.168.201.54@tcp [ 7605.236403] Key type .llcrypt unregistered [ 7605.239117] Key type ._llcrypt unregistered [ 7639.550775] Key type ._llcrypt registered [ 7639.553786] Key type .llcrypt registered [ 7641.101828] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 04:09:09 (1778659749) [ 7644.650664] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7644.689511] alg: No test for adler32 (adler32-zlib) [ 7645.954394] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 7646.255471] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 7647.960315] Key type lgssc registered [ 7649.828554] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7704.241761] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7708.503268] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7728.806386] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7731.499445] Lustre: Mounted lustre-client [ 7784.744449] LustreError: 162315:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d1c33000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7784.849420] Lustre: Unmounted lustre-client [ 7826.323442] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7826.945087] Lustre: Mounted lustre-client [ 7862.639696] LustreError: 162966:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c6ed5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7862.798186] Lustre: Unmounted lustre-client [ 7891.694496] Key type lgssc unregistered [ 7892.057718] LNet: 163374:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7892.069209] LNetError: 163374:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7892.102269] LNet: Removed LNI 192.168.201.54@tcp [ 7893.311603] Key type .llcrypt unregistered [ 7893.313131] Key type ._llcrypt unregistered [ 7912.220898] Key type ._llcrypt registered [ 7912.227065] Key type .llcrypt registered [ 7913.846257] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 04:13:41 (1778660021) [ 7916.816135] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7916.872966] alg: No test for adler32 (adler32-zlib) [ 7918.036539] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 7918.453815] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 7920.199817] Key type lgssc registered [ 7921.608393] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7973.486529] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7978.143061] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7999.861918] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8001.572048] Lustre: Mounted lustre-client [ 8024.457768] LustreError: 166638:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c4998000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8024.534645] Lustre: Unmounted lustre-client [ 8054.938380] Key type lgssc unregistered [ 8055.349597] LNet: 167042:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8055.369152] LNetError: 167042:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8055.400296] LNet: Removed LNI 192.168.201.54@tcp [ 8056.554621] Key type .llcrypt unregistered [ 8056.556311] Key type ._llcrypt unregistered [ 8070.922625] Key type ._llcrypt registered [ 8070.924885] Key type .llcrypt registered [ 8071.624958] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8071.643831] alg: No test for adler32 (adler32-zlib) [ 8072.901991] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 8073.192514] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 8074.920641] Key type lgssc registered [ 8076.546779] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8137.491751] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8142.350798] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8166.119753] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8177.217800] Lustre: Mounted lustre-client [ 8186.131853] LustreError: 169619:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c6ed7000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8186.241944] Lustre: Unmounted lustre-client [ 8213.060571] Key type lgssc unregistered [ 8213.337176] LNet: 170024:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8213.349482] LNetError: 170024:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8213.371235] LNet: Removed LNI 192.168.201.54@tcp [ 8214.438549] Key type .llcrypt unregistered [ 8214.442671] Key type ._llcrypt unregistered [ 8231.278188] Key type ._llcrypt registered [ 8231.281522] Key type .llcrypt registered [ 8232.794489] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 04:19:00 (1778660340) [ 8235.574829] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8235.605202] alg: No test for adler32 (adler32-zlib) [ 8236.803308] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 8237.102128] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 8238.775206] Key type lgssc registered [ 8239.761201] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8295.341865] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8301.560443] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8325.564416] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8328.441705] Lustre: Mounted lustre-client [ 8352.119057] LustreError: 173288:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d4c9e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8352.219739] Lustre: Unmounted lustre-client [ 8383.776336] Key type lgssc unregistered [ 8384.026779] LNet: 173692:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8384.031674] LNetError: 173692:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8384.048658] LNet: Removed LNI 192.168.201.54@tcp [ 8384.801346] Key type .llcrypt unregistered [ 8384.808083] Key type ._llcrypt unregistered [ 8399.123532] Key type ._llcrypt registered [ 8399.224577] Key type .llcrypt registered [ 8399.693572] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8399.710384] alg: No test for adler32 (adler32-zlib) [ 8400.842318] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 8401.066751] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 8402.831220] Key type lgssc registered [ 8404.131060] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8471.862365] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8476.782854] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8505.753638] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8512.054692] Lustre: Mounted lustre-client [ 8521.026599] LustreError: 176279:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c6bce000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8521.153434] Lustre: Unmounted lustre-client [ 8562.008478] Key type lgssc unregistered [ 8562.428295] LNet: 176687:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8562.435271] LNetError: 176687:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8562.461656] LNet: Removed LNI 192.168.201.54@tcp [ 8563.237100] Key type .llcrypt unregistered [ 8563.240767] Key type ._llcrypt unregistered [ 8582.639764] Key type ._llcrypt registered [ 8582.642068] Key type .llcrypt registered [ 8584.373306] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 04:24:52 (1778660692) [ 8608.812338] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8608.876879] alg: No test for adler32 (adler32-zlib) [ 8610.017808] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 8610.198762] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 8611.847234] Key type lgssc registered [ 8613.257488] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8710.937184] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8716.065880] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8743.059250] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8792.618423] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 04:28:20 (1778660900) [ 8828.596847] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8833.290702] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8855.900291] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8858.276444] Lustre: Mounted lustre-client [ 8868.313595] LustreError: 183210:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d8783000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8868.512771] Lustre: Unmounted lustre-client [ 8906.144741] Key type lgssc unregistered [ 8906.500167] LNet: 183615:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8906.504263] LNetError: 183615:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8906.526790] LNet: Removed LNI 192.168.201.54@tcp [ 8907.113213] Key type .llcrypt unregistered [ 8907.115767] Key type ._llcrypt unregistered [ 8923.769774] Key type ._llcrypt registered [ 8923.771611] Key type .llcrypt registered [ 8924.923651] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8926.970571] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 04:30:35 (1778661035) [ 8947.735070] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8947.752907] alg: No test for adler32 (adler32-zlib) [ 8948.895320] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 8949.064764] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 8950.711479] Key type lgssc registered [ 8951.980705] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9054.171488] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9058.076779] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9081.605239] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 9106.127477] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 9109.114167] Lustre: Mounted lustre-client [ 9138.141701] LustreError: 189158:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d3512800: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 9138.208772] Lustre: Unmounted lustre-client [ 9294.031609] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9298.522979] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9320.057441] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9374.409880] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 04:38:02 (1778661482) [ 9376.038280] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9377.922569] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 04:38:06 (1778661486) [ 9476.428092] Key type lgssc unregistered [ 9476.676205] LNet: 194859:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9476.686822] LNetError: 194859:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9476.751369] LNet: Removed LNI 192.168.201.54@tcp [ 9477.638917] Key type .llcrypt unregistered [ 9477.645394] Key type ._llcrypt unregistered [ 9497.024175] Key type ._llcrypt registered [ 9497.025685] Key type .llcrypt registered [ 9498.869924] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 04:40:06 (1778661606) [ 9547.355945] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9547.378834] alg: No test for adler32 (adler32-zlib) [ 9548.598153] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 9548.867766] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 9550.535227] Key type lgssc registered [ 9551.850489] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9598.512460] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9603.235295] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9641.175077] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9670.656606] Key type lgssc unregistered [ 9670.942412] LNet: 198516:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9670.948348] LNetError: 198516:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9670.962224] LNet: Removed LNI 192.168.201.54@tcp [ 9671.781188] Key type .llcrypt unregistered [ 9671.783969] Key type ._llcrypt unregistered [ 9686.794354] Key type ._llcrypt registered [ 9686.796470] Key type .llcrypt registered [ 9688.370601] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 04:43:16 (1778661796) [ 9691.158670] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9691.201398] alg: No test for adler32 (adler32-zlib) [ 9692.436745] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 9692.811123] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 9694.545658] Key type lgssc registered [ 9695.839946] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9742.416244] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9749.262561] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9774.838345] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9776.595714] Lustre: Mounted lustre-client [ 9786.865707] Lustre: lustre-MDT0000-mdc-ffff8ee6c5afb800: Connection to lustre-MDT0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9797.097333] Lustre: lustre-MDT0001-mdc-ffff8ee6c5afb800: Connection to lustre-MDT0001 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9808.287381] Lustre: 199507:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778661901/real 1778661901] req@0000000097ddfd70 x1865062077775872/t0(0) o400->MGC192.168.201.154@tcp@192.168.201.154@tcp:26/25 lens 224/224 e 0 to 1 dl 1778661917 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9808.338477] LustreError: MGC192.168.201.154@tcp: Connection to MGS (at 192.168.201.154@tcp) was lost; in progress operations using this service will fail [ 9833.960172] Lustre: Evicted from MGS (at 192.168.201.154@tcp) after server handle changed from 0xe0df106de8b61510 to 0xe0df106de8b63037 [ 9833.980065] Lustre: MGC192.168.201.154@tcp: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [ 9861.609733] LustreError: lustre-MDT0000-mdc-ffff8ee6c5afb800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9861.640760] Lustre: lustre-MDT0000-mdc-ffff8ee6c5afb800: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [ 9865.557379] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9868.558405] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9875.106356] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9877.749754] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9883.444539] LustreError: 202932:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c5afb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9883.605937] Lustre: Unmounted lustre-client [ 9914.949855] Key type lgssc unregistered [ 9915.312469] LNet: 203336:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9915.337420] LNetError: 203336:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9915.361677] LNet: Removed LNI 192.168.201.54@tcp [ 9916.409455] Key type .llcrypt unregistered [ 9916.411614] Key type ._llcrypt unregistered [ 9933.274483] Key type ._llcrypt registered [ 9933.276488] Key type .llcrypt registered [ 9934.920891] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 04:47:22 (1778662042) [ 9937.864616] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9937.949367] alg: No test for adler32 (adler32-zlib) [ 9939.217207] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [ 9939.495887] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [ 9941.223217] Key type lgssc registered [ 9942.596621] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9998.577973] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10003.429557] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10066.566367] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10071.382661] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10106.871394] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10133.545573] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [10174.648543] Key type lgssc unregistered [10174.967113] LNet: 208458:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10174.972217] LNetError: 208458:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10174.989956] LNet: Removed LNI 192.168.201.54@tcp [10175.762503] Key type .llcrypt unregistered [10175.764105] Key type ._llcrypt unregistered [10221.507267] Key type ._llcrypt registered [10221.509773] Key type .llcrypt registered [10223.515146] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 04:52:11 (1778662331) [10268.875032] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10268.905162] alg: No test for adler32 (adler32-zlib) [10270.248143] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [10270.625528] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [10272.399674] Key type lgssc registered [10274.754699] Lustre: Echo OBD driver; http://www.lustre.org/ [10374.435916] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10379.677067] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10405.264161] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10453.746078] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 04:56:00 (1778662560) [10464.168113] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 04:56:12 (1778662572) [10506.973905] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10511.498475] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10535.674720] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10537.694333] Lustre: Mounted lustre-client [10546.511134] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10550.384794] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10553.495079] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10556.010432] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10563.579519] Lustre: lustre-MDT0000-mdc-ffff8ee6c2e80800: Connection to lustre-MDT0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [10579.936435] Lustre: 210355:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778662673/real 1778662673] req@00000000aba39710 x1865062683781760/t0(0) o400->MGC192.168.201.154@tcp@192.168.201.154@tcp:26/25 lens 224/224 e 0 to 1 dl 1778662689 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10579.961188] LustreError: MGC192.168.201.154@tcp: Connection to MGS (at 192.168.201.154@tcp) was lost; in progress operations using this service will fail [10590.196510] Lustre: Evicted from MGS (at 192.168.201.154@tcp) after server handle changed from 0xe769e502d1a9308f to 0xe769e502d1a932f7 [10590.208311] Lustre: MGC192.168.201.154@tcp: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [10594.141987] Lustre: lustre-MDT0000-mdc-ffff8ee6c2e80800: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [10603.156917] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10605.549225] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10609.474755] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10615.800032] Lustre: lustre-MDT0000-mdc-ffff8ee6c2e80800: Connection to lustre-MDT0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [10632.161071] Lustre: 210358:0:(client.c:2479:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1778662725/real 1778662725] req@000000008b900137 x1865062683791104/t0(0) o400->MGC192.168.201.154@tcp@192.168.201.154@tcp:26/25 lens 224/224 e 0 to 1 dl 1778662741 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10632.198338] LustreError: MGC192.168.201.154@tcp: Connection to MGS (at 192.168.201.154@tcp) was lost; in progress operations using this service will fail [10641.388356] Lustre: Evicted from MGS (at 192.168.201.154@tcp) after server handle changed from 0xe769e502d1a932f7 to 0xe769e502d1a93607 [10641.425490] Lustre: MGC192.168.201.154@tcp: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [10645.864548] Lustre: lustre-MDT0000-mdc-ffff8ee6c2e80800: Connection restored to 192.168.201.154@tcp (at 192.168.201.154@tcp) [10656.331906] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10659.651909] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10666.171953] LustreError: 218624:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c2e80800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10666.339680] Lustre: Unmounted lustre-client [10741.847798] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10747.037104] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10772.120331] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10773.155938] Lustre: Mounted lustre-client [10780.975861] LustreError: 220250:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d1c31800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10781.063196] Lustre: Unmounted lustre-client [10809.529782] Key type lgssc unregistered [10809.796480] LNet: 220653:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10809.807984] LNetError: 220653:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [10809.818946] LNet: Removed LNI 192.168.201.54@tcp [10810.417389] Key type .llcrypt unregistered [10810.420796] Key type ._llcrypt unregistered [10829.675623] Key type ._llcrypt registered [10829.680047] Key type .llcrypt registered [10831.624475] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 05:02:19 (1778662939) [10836.311237] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10836.370739] alg: No test for adler32 (adler32-zlib) [10837.680423] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [10838.087870] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [10839.967929] Key type lgssc registered [10841.786862] Lustre: Echo OBD driver; http://www.lustre.org/ [10899.227129] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10904.948688] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10929.881577] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10931.812279] Lustre: Mounted lustre-client [10939.582351] LustreError: 223832:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c655a000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10939.708434] Lustre: Unmounted lustre-client [11018.604510] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11023.919830] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11047.771496] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11048.802394] Lustre: Mounted lustre-client [11058.495730] LustreError: 225428:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d8780800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11058.568840] Lustre: Unmounted lustre-client [11138.948792] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11145.831700] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11169.690766] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11181.177624] Lustre: Mounted lustre-client [11184.038941] LustreError: 227048:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c7b76800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11184.166271] Lustre: Unmounted lustre-client [11216.745987] Key type lgssc unregistered [11217.164269] LNet: 227451:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11217.185735] LNetError: 227451:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11217.216226] LNet: Removed LNI 192.168.201.54@tcp [11218.478130] Key type .llcrypt unregistered [11218.479729] Key type ._llcrypt unregistered [11237.192170] Key type ._llcrypt registered [11237.193532] Key type .llcrypt registered [11238.818089] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 05:09:06 (1778663346) [11243.794640] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11243.828157] alg: No test for adler32 (adler32-zlib) [11245.054660] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [11245.411806] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [11247.127245] Key type lgssc registered [11248.402530] Lustre: Echo OBD driver; http://www.lustre.org/ [11299.343424] Key type lgssc unregistered [11299.568735] LNet: 229773:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11299.572787] LNetError: 229773:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11299.583438] LNet: Removed LNI 192.168.201.54@tcp [11300.288140] Key type .llcrypt unregistered [11300.290472] Key type ._llcrypt unregistered [11334.777247] Key type ._llcrypt registered [11334.785863] Key type .llcrypt registered [11335.680294] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11335.718039] alg: No test for adler32 (adler32-zlib) [11337.058843] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [11337.406636] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [11339.168081] Key type lgssc registered [11341.576817] Lustre: Echo OBD driver; http://www.lustre.org/ [11438.700702] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11443.071445] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11471.769792] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11520.061072] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11522.312659] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 05:13:50 (1778663630) [11560.598566] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11567.026937] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11593.723354] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11622.017671] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [11624.871702] Lustre: Mounted lustre-client [11630.067742] Lustre: lustre-OST0001-osc-ffff8ee6c7b71800: Connection to lustre-OST0001 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [11638.360904] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11648.716337] Lustre: Unmounted lustre-client [11686.358339] Key type lgssc unregistered [11686.750805] LNet: 236685:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11686.760605] LNetError: 236685:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [11686.798936] LNet: Removed LNI 192.168.201.54@tcp [11687.717918] Key type .llcrypt unregistered [11687.721067] Key type ._llcrypt unregistered [11723.580525] Key type ._llcrypt registered [11723.582209] Key type .llcrypt registered [11725.314991] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 05:17:13 (1778663833) [11744.315921] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11744.343789] alg: No test for adler32 (adler32-zlib) [11745.822450] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [11746.253299] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [11748.135310] Key type lgssc registered [11750.271836] Lustre: Echo OBD driver; http://www.lustre.org/ [11808.124255] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11812.721745] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11837.823612] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 05:19:05 (1778663945) [11874.133724] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11879.363615] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11903.504605] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11906.347524] Lustre: Mounted lustre-client [11916.984570] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11926.926735] Lustre: Unmounted lustre-client [12037.288584] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12043.672579] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12093.290232] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12094.486058] Lustre: Mounted lustre-client [12098.284884] LustreError: 243731:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d8785800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12098.439584] Lustre: Unmounted lustre-client [12133.401498] Key type lgssc unregistered [12133.788082] LNet: 244135:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12133.794699] LNetError: 244135:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [12134.831860] LNet: Removed LNI 192.168.201.54@tcp [12135.686506] Key type .llcrypt unregistered [12135.689181] Key type ._llcrypt unregistered [12169.368062] Key type ._llcrypt registered [12169.390382] Key type .llcrypt registered [12169.915234] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12169.931388] alg: No test for adler32 (adler32-zlib) [12171.145601] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [12171.497317] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [12173.335173] Key type lgssc registered [12174.870662] Lustre: Echo OBD driver; http://www.lustre.org/ [12267.587574] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12272.600661] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12299.747824] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12344.846221] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12347.646793] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 05:27:35 (1778664455) [12386.877405] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12392.612401] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12417.643928] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12423.580807] Lustre: Mounted lustre-client [12427.887148] LustreError: 250199:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d359e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12428.049507] Lustre: Unmounted lustre-client [12459.912075] Key type lgssc unregistered [12460.240481] LNet: 250603:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12460.254753] LNetError: 250603:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [12460.280422] LNet: Removed LNI 192.168.201.54@tcp [12461.055485] Key type .llcrypt unregistered [12461.058383] Key type ._llcrypt unregistered [12480.178678] Key type ._llcrypt registered [12480.180475] Key type .llcrypt registered [12481.765263] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12484.501875] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 05:29:51 (1778664591) [12497.318586] Key type .llcrypt unregistered [12497.324621] Key type ._llcrypt unregistered [12508.125515] Key type ._llcrypt registered [12508.128647] Key type .llcrypt registered [12508.874244] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12508.885603] alg: No test for adler32 (adler32-zlib) [12510.205503] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [12510.546609] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [12512.279776] Key type lgssc registered [12514.666318] Lustre: Echo OBD driver; http://www.lustre.org/ [12574.782400] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12594.308837] Lustre: Mounted lustre-client [12597.663831] LustreError: 253625:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c2e83800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12597.746491] Lustre: Unmounted lustre-client [12626.653393] Key type lgssc unregistered [12626.871404] LNet: 254030:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12626.875846] LNetError: 254030:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [12626.917255] LNet: Removed LNI 192.168.201.54@tcp [12627.647545] Key type .llcrypt unregistered [12627.649624] Key type ._llcrypt unregistered [12649.174836] Key type ._llcrypt registered [12649.177563] Key type .llcrypt registered [12651.793863] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 05:32:38 (1778664758) [12656.473805] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12656.503568] alg: No test for adler32 (adler32-zlib) [12657.663430] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [12657.950709] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [12659.671985] Key type lgssc registered [12661.203111] Lustre: Echo OBD driver; http://www.lustre.org/ [12747.280508] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12783.614837] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12788.489381] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12791.486852] Lustre: Mounted lustre-client [12796.259621] LustreError: 257082:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c538c800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12796.402902] Lustre: Unmounted lustre-client [12821.525615] Key type lgssc unregistered [12821.885863] LNet: 257484:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12821.904933] LNetError: 257484:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [12821.942344] LNet: Removed LNI 192.168.201.54@tcp [12822.919381] Key type .llcrypt unregistered [12822.922546] Key type ._llcrypt unregistered [12843.963177] Key type ._llcrypt registered [12843.973230] Key type .llcrypt registered [12846.287982] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 05:35:53 (1778664953) [12849.244469] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12849.274832] alg: No test for adler32 (adler32-zlib) [12850.370613] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [12850.585263] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [12852.295420] Key type lgssc registered [12853.812892] Lustre: Echo OBD driver; http://www.lustre.org/ [12907.475506] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [12913.002413] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [12937.088267] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [12939.849835] Lustre: Mounted lustre-client [12944.875079] Lustre: lustre-MDT0000-mdc-ffff8ee6d4c9f800: Connection to lustre-MDT0000 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [12950.111636] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12950.138533] LustreError: 260553:0:(file.c:6098:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12950.496336] LustreError: 260572:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d4c9f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [12950.511806] LustreError: MGC192.168.201.154@tcp: Connection to MGS (at 192.168.201.154@tcp) was lost; in progress operations using this service will fail [12950.664522] Lustre: Unmounted lustre-client [12972.131592] Key type lgssc unregistered [12972.481737] LNet: 260967:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12972.488730] LNetError: 260967:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [12972.514213] LNet: Removed LNI 192.168.201.54@tcp [12973.500959] Key type .llcrypt unregistered [12973.503192] Key type ._llcrypt unregistered [12992.985746] Key type ._llcrypt registered [12992.989056] Key type .llcrypt registered [12994.929881] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 05:38:22 (1778665102) [12997.985540] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12998.003547] alg: No test for adler32 (adler32-zlib) [12999.264650] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [12999.700543] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [13001.479484] Key type lgssc registered [13003.406889] Lustre: Echo OBD driver; http://www.lustre.org/ [13062.661898] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13068.063434] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13089.842823] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13091.666138] Lustre: Mounted lustre-client [13111.050661] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13114.706901] LustreError: 264071:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d1c30000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [13114.798341] Lustre: Unmounted lustre-client [13134.311757] Key type lgssc unregistered [13134.745167] LNet: 264466:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13134.756293] LNetError: 264466:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [13135.790178] LNet: Removed LNI 192.168.201.54@tcp [13136.837912] Key type .llcrypt unregistered [13136.840536] Key type ._llcrypt unregistered [13161.635919] Key type ._llcrypt registered [13161.639020] Key type .llcrypt registered [13163.400222] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 05:41:11 (1778665271) [13186.241592] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13186.267704] alg: No test for adler32 (adler32-zlib) [13187.440500] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [13187.791283] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [13189.463221] Key type lgssc registered [13191.319705] Lustre: Echo OBD driver; http://www.lustre.org/ [13315.177981] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13318.221098] Lustre: Mounted lustre-client [13364.209543] Lustre: lustre-MDT0001-mdc-ffff8ee6d63d8800: Connection to lustre-MDT0001 (at 192.168.201.154@tcp) was lost; in progress operations using this service will wait for recovery to complete [13371.991974] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13382.351126] Lustre: Unmounted lustre-client [13412.558298] Key type lgssc unregistered [13412.864056] LNet: 270227:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13412.869703] LNetError: 270227:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [13412.887807] LNet: Removed LNI 192.168.201.54@tcp [13413.853265] Key type .llcrypt unregistered [13413.858920] Key type ._llcrypt unregistered [13431.970715] Key type ._llcrypt registered [13431.974490] Key type .llcrypt registered [13433.238572] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 05:45:41 (1778665541) [13434.936881] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13436.941847] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 05:45:45 (1778665545) [13438.714238] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13441.482776] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 05:45:48 (1778665548) [13443.934259] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13446.607907] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 05:45:54 (1778665554) [13448.529123] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13450.687154] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 05:45:58 (1778665558) [13452.896223] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13456.051429] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 05:46:03 (1778665563) [13466.043245] Key type .llcrypt unregistered [13466.045518] Key type ._llcrypt unregistered [13474.892062] Key type ._llcrypt registered [13474.896655] Key type .llcrypt registered [13475.337240] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13475.358640] alg: No test for adler32 (adler32-zlib) [13476.576737] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [13476.992441] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [13478.968721] Key type lgssc registered [13480.779575] Lustre: Echo OBD driver; http://www.lustre.org/ [13567.609959] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13572.209828] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13597.349981] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13599.240385] Lustre: Mounted lustre-client [13602.619610] LustreError: 275828:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d1c37000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [13602.764735] Lustre: Unmounted lustre-client [13644.601826] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 05:49:12 (1778665752) [13690.482867] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [13695.653658] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [13731.692466] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [13732.739664] Lustre: Mounted lustre-client [13735.355439] LustreError: 277942:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6c68ad000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [13735.476075] Lustre: Unmounted lustre-client [13779.387918] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 05:51:27 (1778665887) [13791.394227] LNet: 1 local NIs in recovery (showing 1): 192.168.201.54@tcp [14436.595440] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14440.769799] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14476.885610] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14590.278218] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 06:04:58 (1778666698) [14606.395673] Key type lgssc unregistered [14606.933339] LNet: 283510:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14606.946707] LNetError: 283510:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [14606.977783] LNet: Removed LNI 192.168.201.54@tcp [14608.537941] Key type .llcrypt unregistered [14608.540974] Key type ._llcrypt unregistered [14728.118101] Key type ._llcrypt registered [14728.120150] Key type .llcrypt registered [14728.901320] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14728.911937] alg: No test for adler32 (adler32-zlib) [14730.157864] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [14730.590922] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [14732.463202] Key type lgssc registered [14734.708156] Lustre: Echo OBD driver; http://www.lustre.org/ [14835.604709] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [14840.320152] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [14865.215141] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [14911.766261] Key type lgssc unregistered [14912.183606] LNet: 287123:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14912.205671] LNetError: 287123:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [14912.229610] LNet: Removed LNI 192.168.201.54@tcp [14913.183821] Key type .llcrypt unregistered [14913.188238] Key type ._llcrypt unregistered [14951.554325] Key type ._llcrypt registered [14951.559300] Key type .llcrypt registered [14953.165859] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 06:11:01 (1778667061) [14977.035311] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14977.124113] alg: No test for adler32 (adler32-zlib) [14978.316075] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [14978.692901] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [14980.399186] Key type lgssc registered [14981.654929] Lustre: Echo OBD driver; http://www.lustre.org/ [15042.285248] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 06:12:30 (1778667150) [15057.215583] Key type lgssc unregistered [15057.586320] LNet: 290679:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15057.597592] LNetError: 290679:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [15057.631371] LNet: Removed LNI 192.168.201.54@tcp [15058.411841] Key type .llcrypt unregistered [15058.414572] Key type ._llcrypt unregistered [15071.699422] Key type ._llcrypt registered [15071.703542] Key type .llcrypt registered [15072.463487] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15072.491460] alg: No test for adler32 (adler32-zlib) [15073.740628] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [15074.145091] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [15075.847807] Key type lgssc registered [15077.107357] Lustre: Echo OBD driver; http://www.lustre.org/ [15135.720668] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15138.649418] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15165.305321] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15470.060280] LNet: Added LNI 192.168.201.54@tcp50 [8/256/0/180] [15473.432265] LNet: Removed LNI 192.168.201.54@tcp [15475.828997] Lustre: 294992:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8ee6e090f000: config has no valid NIDs, force dynamic NIDs [15477.153163] Lustre: Mounted lustre-client [15477.244948] LustreError: 295002:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6e090f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [15477.371165] Lustre: Unmounted lustre-client [15481.070701] Key type lgssc unregistered [15481.838704] LNet: 295252:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15481.857496] LNetError: 295252:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [15481.890871] LNet: Removed LNI 192.168.201.54@tcp50 [15482.972911] Key type .llcrypt unregistered [15482.986611] Key type ._llcrypt unregistered [15503.628886] Key type ._llcrypt registered [15503.630599] Key type .llcrypt registered [15503.982540] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15503.998231] alg: No test for adler32 (adler32-zlib) [15505.173564] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [15505.637886] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [15507.399182] Key type lgssc registered [15509.195389] Lustre: Echo OBD driver; http://www.lustre.org/ [15568.647543] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15572.578825] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15580.653721] LNet: Added LNI 192.168.201.54@tcp50 [8/256/0/180] [15581.490935] LNet: Removed LNI 192.168.201.54@tcp [15582.686152] Lustre: 297885:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8ee6d2aa1000: config has no valid NIDs, force dynamic NIDs [15583.927833] Lustre: Mounted lustre-client [15584.407457] LustreError: 297915:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6d2aa1000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [15584.511351] Lustre: Unmounted lustre-client [15620.398401] Key type lgssc unregistered [15620.685547] LNet: 298757:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15620.706323] LNetError: 298757:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [15620.717797] LNet: Removed LNI 192.168.201.54@tcp50 [15621.398119] Key type .llcrypt unregistered [15621.401589] Key type ._llcrypt unregistered [15635.820873] Key type ._llcrypt registered [15635.824755] Key type .llcrypt registered [15637.934687] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 06:22:25 (1778667745) [15661.555379] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15661.592274] alg: No test for adler32 (adler32-zlib) [15662.729452] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [15662.972418] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [15664.671192] Key type lgssc registered [15666.215360] Lustre: Echo OBD driver; http://www.lustre.org/ [15756.630674] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15760.776275] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15784.472621] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15819.262357] Key type lgssc unregistered [15819.594037] LNet: 303418:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15819.602435] LNetError: 303418:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [15819.632955] LNet: Removed LNI 192.168.201.54@tcp [15820.674932] Key type .llcrypt unregistered [15820.677654] Key type ._llcrypt unregistered [15832.597211] Key type ._llcrypt registered [15832.601673] Key type .llcrypt registered [15834.191406] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 06:25:42 (1778667942) [15837.179649] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15837.214657] alg: No test for adler32 (adler32-zlib) [15838.559254] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [15838.936757] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [15840.679183] Key type lgssc registered [15842.265420] Lustre: Echo OBD driver; http://www.lustre.org/ [15899.055474] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [15904.532811] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [15928.130525] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [15929.812342] Lustre: Mounted lustre-client [15993.211148] Lustre: Mounted fs15246-client [16010.394958] LustreError: 307566:0:(lov_obd.c:792:lov_cleanup()) fs15246-clilov-ffff8ee6d63d9000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [16010.483767] Lustre: Unmounted fs15246-client [16043.093387] LustreError: 307785:0:(lov_obd.c:792:lov_cleanup()) lustre-clilov-ffff8ee6e0823800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [16043.149464] Lustre: Unmounted lustre-client [16090.399273] Key type lgssc unregistered [16090.705451] LNet: 308192:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16090.719059] LNetError: 308192:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [16090.735364] LNet: Removed LNI 192.168.201.54@tcp [16091.817043] Key type .llcrypt unregistered [16091.825955] Key type ._llcrypt unregistered [16106.817898] Key type ._llcrypt registered [16106.826059] Key type .llcrypt registered [16108.655758] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 06:30:16 (1778668216) [16110.840554] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16110.875131] alg: No test for adler32 (adler32-zlib) [16112.018699] Lustre: Lustre: Build Version: 2.17.53_3_gb43cd8a [16112.286898] LNet: Added LNI 192.168.201.54@tcp [8/256/0/180] [16113.983171] Key type lgssc registered [16115.498550] Lustre: Echo OBD driver; http://www.lustre.org/ [16264.923951] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [16268.992267] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [16290.222874] Lustre: DEBUG MARKER: oleg154-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [16405.430288] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16094 sec ========= 06:35:13 (1778668513) [16407.447941] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 06:35:15 (1778668515) === [16411.340352] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 06:35:19 (1778668519) === [16450.664883] Key type lgssc unregistered [16450.966467] LNet: 317371:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16450.971433] LNetError: 317371:0:(acceptor.c:246:lnet_acceptor_remove_socket()) Interface ens2 not found [16450.987168] LNet: Removed LNI 192.168.201.54@tcp [16451.652598] Key type .llcrypt unregistered [16451.658178] Key type ._llcrypt unregistered