[ 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 3.0.0 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.3-2.fc40 04/01/2014 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 436789153 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 0x000f5410-0x000f541f] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F5220 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE1D6F 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE1C0B 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 001BCB (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE1C7F 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE1D0F 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE1D47 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe1c0b-0xbffe1c7e] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1c0a] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe1c7f-0xbffe1d0e] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe1d0f-0xbffe1d46] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe1d47-0xbffe1d6e] [ 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 2528MB 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.001009] APIC: Switch to symmetric I/O mode setup [ 0.002332] x2apic enabled [ 0.003004] Switched APIC routing to physical x2apic. [ 0.004007] kvm-guest: setup PV IPIs [ 0.006000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.006000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.006029] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.007012] pid_max: default: 32768 minimum: 301 [ 0.009051] LSM: Security Framework initializing [ 0.010041] Yama: becoming mindful. [ 0.010682] SELinux: Initializing. [ 0.011056] *** VALIDATE selinux *** [ 0.019325] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024635] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025163] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026105] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027140] *** VALIDATE tmpfs *** [ 0.028416] *** VALIDATE proc *** [ 0.029239] *** VALIDATE cgroup *** [ 0.030008] *** VALIDATE cgroup2 *** [ 0.032023] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.033110] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.034004] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.035024] Spectre V2 : User space: Vulnerable [ 0.036005] Speculative Store Bypass: Vulnerable [ 0.038705] debug: unmapping init [mem 0xffffffffb4059000-0xffffffffb4060fff] [ 0.040155] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.041483] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.042018] ... version: 2 [ 0.042735] ... bit width: 48 [ 0.043008] ... generic registers: 4 [ 0.043804] ... value mask: 0000ffffffffffff [ 0.044011] ... max period: 00007fffffffffff [ 0.045007] ... fixed-purpose events: 3 [ 0.046008] ... event mask: 000000070000000f [ 0.048205] rcu: Hierarchical SRCU implementation. [ 0.050513] smp: Bringing up secondary CPUs ... [ 0.051397] x86: Booting SMP configuration: [ 0.052012] .... node #0, CPUs: #1 #2 #3 [ 0.055266] smp: Brought up 1 node, 4 CPUs [ 0.057013] smpboot: Max logical packages: 1 [ 0.058019] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.274028] node 0 deferred pages initialised in 214ms [ 0.276527] devtmpfs: initialized [ 0.277193] x86/mm: Memory block size: 128MB [ 0.279172] gcov: version magic: 0x41383552 [ 0.280674] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.283126] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.284345] pinctrl core: initialized pinctrl subsystem [ 0.285097] [ 0.285365] ************************************************************* [ 0.287009] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.288009] ** ** [ 0.289007] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.291009] ** ** [ 0.292009] ** This means that this kernel is built to expose internal ** [ 0.294016] ** IOMMU data structures, which may compromise security on ** [ 0.297013] ** your system. ** [ 0.299007] ** ** [ 0.300006] ** If you see this message and you are not debugging the ** [ 0.301008] ** kernel, report this immediately to your vendor! ** [ 0.303010] ** ** [ 0.306010] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.308011] ************************************************************* [ 0.309621] NET: Registered protocol family 16 [ 0.311290] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.312056] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.314027] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.316078] cpuidle: using governor menu [ 0.317397] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.320133] PCI: Using configuration type 1 for base access [ 0.322154] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.330108] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.331010] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.332161] cryptd: max_cpu_qlen set to 1000 [ 0.336321] ACPI: Added _OSI(Module Device) [ 0.338020] ACPI: Added _OSI(Processor Device) [ 0.340013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.341017] ACPI: Added _OSI(Processor Aggregator Device) [ 0.345523] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.350310] ACPI: Interpreter enabled [ 0.351038] ACPI: PM: (supports S0 S3 S4 S5) [ 0.353008] ACPI: Using IOAPIC for interrupt routing [ 0.354094] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.357327] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.365812] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.367026] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.369011] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.371053] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.374083] acpiphp: Slot [2] registered [ 0.376068] acpiphp: Slot [5] registered [ 0.376849] acpiphp: Slot [6] registered [ 0.377070] acpiphp: Slot [3] registered [ 0.378040] acpiphp: Slot [4] registered [ 0.380064] acpiphp: Slot [7] registered [ 0.381083] acpiphp: Slot [8] registered [ 0.383067] acpiphp: Slot [9] registered [ 0.384094] acpiphp: Slot [10] registered [ 0.386093] acpiphp: Slot [11] registered [ 0.387088] acpiphp: Slot [12] registered [ 0.389078] acpiphp: Slot [13] registered [ 0.389979] acpiphp: Slot [14] registered [ 0.391077] acpiphp: Slot [15] registered [ 0.392074] acpiphp: Slot [16] registered [ 0.394070] acpiphp: Slot [17] registered [ 0.394958] acpiphp: Slot [18] registered [ 0.395067] acpiphp: Slot [19] registered [ 0.397080] acpiphp: Slot [20] registered [ 0.399055] acpiphp: Slot [21] registered [ 0.399916] acpiphp: Slot [22] registered [ 0.400078] acpiphp: Slot [23] registered [ 0.400949] acpiphp: Slot [24] registered [ 0.402057] acpiphp: Slot [25] registered [ 0.402958] acpiphp: Slot [26] registered [ 0.404043] acpiphp: Slot [27] registered [ 0.404958] acpiphp: Slot [28] registered [ 0.406051] acpiphp: Slot [29] registered [ 0.407085] acpiphp: Slot [30] registered [ 0.408062] acpiphp: Slot [31] registered [ 0.409044] PCI host bridge to bus 0000:00 [ 0.410022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.412013] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.414026] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.417036] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.418013] pci_bus 0000:00: root bus resource [mem 0x380000000000-0x38007fffffff window] [ 0.420019] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.421230] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.424081] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.427297] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.434017] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.437588] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.441021] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.443015] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.446031] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.448611] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.451760] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.454034] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.455660] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.459534] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.466021] pci 0000:00:02.0: reg 0x20: [mem 0x380000000000-0x380000003fff 64bit pref] [ 0.470030] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.475325] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.482027] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.487014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.499021] pci 0000:00:05.0: reg 0x20: [mem 0x380000004000-0x380000007fff 64bit pref] [ 0.507710] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.513017] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.519011] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.530019] pci 0000:00:06.0: reg 0x20: [mem 0x380000008000-0x38000000bfff 64bit pref] [ 0.539180] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.541265] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.543268] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.545337] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.547131] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.551140] iommu: Default domain type: Passthrough [ 0.553414] SCSI subsystem initialized [ 0.555103] ACPI: bus type USB registered [ 0.556071] usbcore: registered new interface driver usbfs [ 0.557031] usbcore: registered new interface driver hub [ 0.558053] usbcore: registered new device driver usb [ 0.560108] pps_core: LinuxPPS API ver. 1 registered [ 0.561018] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.564074] PTP clock support registered [ 0.566045] EDAC MC: Ver: 3.0.0 [ 0.567324] PCI: Using ACPI for IRQ routing [ 0.568373] NetLabel: Initializing [ 0.569006] NetLabel: domain hash size = 128 [ 0.570012] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.572086] NetLabel: unlabeled traffic allowed by default [ 0.574092] vgaarb: loaded [ 0.575205] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.576006] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.580440] clocksource: Switched to clocksource kvm-clock [ 0.678484] VFS: Disk quotas dquot_6.6.0 [ 0.679378] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.680858] *** VALIDATE ramfs *** [ 0.681447] *** VALIDATE hugetlbfs *** [ 0.682320] pnp: PnP ACPI init [ 0.684703] pnp: PnP ACPI: found 6 devices [ 0.697159] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.699652] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.701746] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.703407] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.705983] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.707273] pci_bus 0000:00: resource 8 [mem 0x380000000000-0x38007fffffff window] [ 0.708992] NET: Registered protocol family 2 [ 0.710554] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.713852] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.716242] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.721528] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.724560] TCP: Hash tables configured (established 65536 bind 65536) [ 0.726572] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.728988] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.730896] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.732891] NET: Registered protocol family 1 [ 0.735185] RPC: Registered named UNIX socket transport module. [ 0.737328] RPC: Registered udp transport module. [ 0.739089] RPC: Registered tcp transport module. [ 0.740312] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.742468] NET: Registered protocol family 44 [ 0.743968] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.745319] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.746493] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.747789] PCI: CLS 0 bytes, default 64 [ 0.749150] Unpacking initramfs... [ 2.185065] debug: unmapping init [mem 0xffff99bf7cc64000-0xffff99bf7ffcffff] [ 2.187973] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.189256] software IO TLB: mapped [mem 0x00000000b8c64000-0x00000000bcc64000] (64MB) [ 2.192192] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.700263] Initialise system trusted keyrings [ 2.701863] Key type blacklist registered [ 2.704180] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.713369] zbud: loaded [ 2.717719] *** VALIDATE nfs *** [ 2.719130] *** VALIDATE nfs4 *** [ 2.721312] pstore: using deflate compression [ 2.725519] Platform Keyring initialized [ 2.853192] NET: Registered protocol family 38 [ 2.855121] Key type asymmetric registered [ 2.856758] Asymmetric key parser 'x509' registered [ 2.858683] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.861462] io scheduler mq-deadline registered [ 2.863007] io scheduler kyber registered [ 2.864472] io scheduler bfq registered [ 2.867168] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.869489] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.871683] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.873899] ACPI: Power Button [PWRF] [ 2.964846] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.060434] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.161867] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.191063] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.228313] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.234048] Non-volatile memory driver v1.3 [ 3.235945] Linux agpgart interface v0.103 [ 3.265598] virtio_blk virtio1: [vda] 133640 512-byte logical blocks (68.4 MB/65.3 MiB) [ 3.269601] vda: detected capacity change from 0 to 68423680 [ 3.285923] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.288535] vdb: detected capacity change from 0 to 1073741824 [ 3.298835] libphy: Fixed MDIO Bus: probed [ 3.304913] usbcore: registered new interface driver usbserial_generic [ 3.308600] usbserial: USB Serial support registered for generic [ 3.311076] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.315994] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.317755] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.320177] mousedev: PS/2 mouse device common for all mice [ 3.325316] rtc_cmos 00:05: RTC can wake from S4 [ 3.331458] rtc_cmos 00:05: registered as rtc0 [ 3.334253] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.334260] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.343099] intel_pstate: CPU model not supported [ 3.343110] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.348423] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.349200] hid: raw HID events driver (C) Jiri Kosina [ 3.353720] usbcore: registered new interface driver usbhid [ 3.355874] usbhid: USB HID core driver [ 3.357325] drop_monitor: Initializing network drop monitor service [ 3.359302] Initializing XFRM netlink socket [ 3.360778] NET: Registered protocol family 10 [ 3.364941] Segment Routing with IPv6 [ 3.366231] NET: Registered protocol family 17 [ 3.367950] mpls_gso: MPLS GSO support [ 3.375411] RAS: Correctable Errors collector initialized. [ 3.378931] AVX version of gcm_enc/dec engaged. [ 3.380910] AES CTR mode by8 optimization enabled [ 3.502169] sched_clock: Marking stable (3502101033, 0)->(4316712045, -814611012) [ 3.517720] registered taskstats version 1 [ 3.520227] Loading compiled-in X.509 certificates [ 3.522929] zswap: loaded using pool lzo/zbud [ 3.568134] Key type big_key registered [ 3.580593] Key type encrypted registered [ 3.582143] ima: No TPM chip found, activating TPM-bypass! [ 3.584197] ima: Allocated hash algorithm: sha1 [ 3.585849] ima: No architecture policies found [ 3.587633] evm: Initialising EVM extended attributes: [ 3.589232] evm: security.selinux [ 3.591204] evm: security.ima [ 3.592282] evm: security.capability [ 3.593463] evm: HMAC attrs: 0x1 [ 3.598142] rtc_cmos 00:05: setting system clock to 2025-12-03 19:41:47 UTC (1764790907) [ 3.605284] debug: unmapping init [mem 0xffffffffb5003000-0xffffffffb51fffff] [ 3.608261] debug: unmapping init [mem 0xffffffffb3d82000-0xffffffffb4058fff] [ 3.615321] Write protecting the kernel read-only data: 28672k [ 3.620107] debug: unmapping init [mem 0xffffffffb2403000-0xffffffffb25fffff] [ 3.623916] debug: unmapping init [mem 0xffffffffb2d14000-0xffffffffb2dfffff] [ 3.668642] 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.684728] systemd[1]: Detected virtualization kvm. [ 3.686414] systemd[1]: Detected architecture x86-64. [ 3.688140] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.716643] systemd[1]: No hostname configured. [ 3.718341] systemd[1]: Set hostname to . [ 3.720428] random: systemd: uninitialized urandom read (16 bytes read) [ 3.722712] systemd[1]: Initializing machine ID from random generator. [ 3.786345] random: ln: uninitialized urandom read (6 bytes read) [ 3.908269] random: systemd: uninitialized urandom read (16 bytes read) [ 3.910575] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 3.916955] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.923396] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... [ OK ] Reached target Timers. Starting Create Volatile Files and Directories... [ OK ] Reached target Initrd Root Device. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Started Memstrack Anylazing Service. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Reached target Swap. [ OK ] Started Apply Kernel Variables. [ 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. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.999088] device-mapper: uevent: version 1.0.3 [ 5.001954] 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. [ 6.057453] virtio_net virtio0 ens2: renamed from eth0 Starting dracut initqueue hook... [ 6.090028] random: fast init done [ 6.139213] scsi host0: ata_piix [ 6.174909] scsi host1: ata_piix [ 6.176278] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 6.178308] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 11.127302] random: crng init done [ 11.149487] random: 7 urandom warning(s) missed due to ratelimiting [ 11.898718] dracut-initqueue[592]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 13.715422] hrtimer: interrupt took 11503972 ns [ 13.802063] 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. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ 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. [ OK ] Stopped target Swap. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Slices. [ OK ] Stopped udev Kernel Device Manager. [ 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... [ 16.210859] printk: systemd: 25 output lines suppressed due to ratelimiting [ 17.054971] SELinux: Disabled at runtime. [ 17.140180] 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) [ 17.152779] systemd[1]: Detected virtualization kvm. [ 17.154980] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 18.325521] systemd[1]: initrd-switch-root.service: Succeeded. [ 18.329714] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 18.336622] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 18.342018] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 18.346249] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 18.363522] systemd[1]: Starting Journal Service... Starting Journal Service... [ 18.372667] systemd[1]: Created slice User and Session Slice. [ OK ] Created slice User and Session Slice. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. Mounting Huge Pages File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target Paths. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Remount Root and Kernel File Systems... [ OK ] Reached target RPC Port Mapper. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Process Core Dump Socket. Mounting Kernel Debug File System... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting POSIX Message Queue File System... [ OK ] Reached target Slices. Starting Apply Kernel Variables... Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Created slice system-getty.slice[ 18.773028] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS . [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Huge Pages File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 19.320402] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 19.987943] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 20.048751] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 20.486393] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 20.593801] EDAC sbridge: Ver: 1.1.2 [ 22.479976] Key type dns_resolver registered [ 22.814939] NFS: Registering the id_resolver key type [ 22.816533] Key type id_resolver registered [ 22.818481] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Mark the need to relabel after reboot... Starting Load/Save Random Seed... [ 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 dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... 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 Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg105-client login: [ 57.124348] libcfs: loading out-of-tree module taints kernel. [ 57.234285] Key type ._llcrypt registered [ 57.241561] Key type .llcrypt registered [ 57.544160] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 57.550339] alg: No test for adler32 (adler32-zlib) [ 58.540730] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 58.867177] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 60.487155] Key type lgssc registered [ 61.005439] Lustre: Echo OBD driver; http://www.lustre.org/ [ 122.189832] Lustre: Mounted lustre-client [ 124.695264] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 139.091535] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing check_logdir /tmp/testlogs/ [ 141.899536] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing yml_node [ 145.246965] Lustre: DEBUG MARKER: Client: 2.16.59.23 [ 146.935584] Lustre: DEBUG MARKER: MDS: 2.16.59.23 [ 147.935731] Lustre: lustre-OST0000-osc-ffff99bfe0e6b000: disconnect after 24s idle [ 148.781432] Lustre: DEBUG MARKER: OSS: 2.16.59.23 [ 150.061926] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Dec 3 14:44:12 EST 2025 [ 163.338735] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 164.252155] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 165.214415] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 175.462918] LustreError: 8983:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 175.480123] Lustre: Unmounted lustre-client [ 227.068172] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 230.542801] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 249.524272] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 281.784467] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 14:46:24 (1764791184) [ 283.196621] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 284.280232] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 14:46:27 (1764791187) [ 319.060593] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 324.716759] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 341.220025] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 341.739406] Lustre: Mounted lustre-client [ 353.492185] LustreError: 14418:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc521f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 353.513554] LustreError: 14418:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 353.519406] LustreError: 14418:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 353.596379] Lustre: Unmounted lustre-client [ 381.112788] Key type lgssc unregistered [ 381.255081] LNet: 14826:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 381.258496] LNetError: 14826:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 381.273319] LNet: Removed LNI 192.168.201.5@tcp [ 381.682143] Key type .llcrypt unregistered [ 381.684582] Key type ._llcrypt unregistered [ 389.961635] Key type ._llcrypt registered [ 389.963261] Key type .llcrypt registered [ 390.685158] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 14:48:13 (1764791293) [ 391.346072] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 391.378042] alg: No test for adler32 (adler32-zlib) [ 392.326600] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 392.451251] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 394.047228] Key type lgssc registered [ 394.787914] Lustre: Echo OBD driver; http://www.lustre.org/ [ 466.023103] Lustre: Mounted lustre-client [ 554.683870] LustreError: 18134:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd0a4a800: lov tgt 1990 not cleaned! deathrow=0, lovrc=1 [ 554.692055] LustreError: 18134:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 554.712206] Lustre: Unmounted lustre-client [ 571.823523] Key type lgssc unregistered [ 571.985481] LNet: 18597:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 571.989386] LNetError: 18597:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 572.002105] LNet: Removed LNI 192.168.201.5@tcp [ 572.337066] Key type .llcrypt unregistered [ 572.338818] Key type ._llcrypt unregistered [ 576.601969] Key type ._llcrypt registered [ 576.603553] Key type .llcrypt registered [ 577.184744] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 14:51:20 (1764791480) [ 578.232036] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 578.245091] alg: No test for adler32 (adler32-zlib) [ 579.131618] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 579.253325] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 580.855181] Key type lgssc registered [ 581.351018] Lustre: Echo OBD driver; http://www.lustre.org/ [ 599.533663] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 600.709314] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 607.042908] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 617.463198] Lustre: Mounted lustre-client [ 621.880236] LustreError: 21694:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd284c000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 621.890125] LustreError: 21694:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 621.921905] Lustre: Unmounted lustre-client [ 639.512131] Key type lgssc unregistered [ 639.627574] LNet: 22097:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 639.629850] LNetError: 22097:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 639.636642] LNet: Removed LNI 192.168.201.5@tcp [ 639.851736] Key type .llcrypt unregistered [ 639.853361] Key type ._llcrypt unregistered [ 643.315900] Key type ._llcrypt registered [ 643.317246] Key type .llcrypt registered [ 643.778080] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 14:52:27 (1764791547) [ 644.565814] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 644.573341] alg: No test for adler32 (adler32-zlib) [ 645.436046] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 645.516186] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 647.103214] Key type lgssc registered [ 647.548950] Lustre: Echo OBD driver; http://www.lustre.org/ [ 664.302786] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 665.707020] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 675.931450] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 682.510167] Lustre: Mounted lustre-client [ 686.765133] LustreError: 24786:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc355e000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 686.779408] LustreError: 24786:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 686.830482] Lustre: Unmounted lustre-client [ 724.007562] Key type lgssc unregistered [ 724.185374] LNet: 25189:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 724.192280] LNetError: 25189:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 724.208546] LNet: Removed LNI 192.168.201.5@tcp [ 724.666672] Key type .llcrypt unregistered [ 724.668844] Key type ._llcrypt unregistered [ 732.407401] Key type ._llcrypt registered [ 732.409033] Key type .llcrypt registered [ 733.053182] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 14:53:56 (1764791636) [ 734.139103] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 734.151839] alg: No test for adler32 (adler32-zlib) [ 735.039433] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 735.148605] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 736.751250] Key type lgssc registered [ 737.255091] Lustre: Echo OBD driver; http://www.lustre.org/ [ 757.953967] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 759.466558] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 768.090843] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 775.729971] Lustre: Mounted lustre-client [ 785.915578] Lustre: lustre-MDT0000-mdc-ffff99bfc863f800: Connection to lustre-MDT0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 796.156249] Lustre: lustre-MDT0001-mdc-ffff99bfc863f800: Connection to lustre-MDT0001 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 801.660803] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 806.367191] Lustre: 26145:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1764791694/real 1764791694] req@0000000007c11135 x1850518157662848/t0(0) o400->MGC192.168.201.105@tcp@192.168.201.105@tcp:26/25 lens 224/224 e 0 to 1 dl 1764791710 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 806.407758] LustreError: MGC192.168.201.105@tcp: Connection to MGS (at 192.168.201.105@tcp) was lost; in progress operations using this service will fail [ 811.987321] LustreError: 28357:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 812.039990] Lustre: Unmounted lustre-client [ 830.439712] Key type lgssc unregistered [ 830.732191] LNet: 28749:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 830.741115] LNetError: 28749:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 830.765654] LNet: Removed LNI 192.168.201.5@tcp [ 831.383993] Key type .llcrypt unregistered [ 831.390184] Key type ._llcrypt unregistered [ 845.835907] Key type ._llcrypt registered [ 845.837174] Key type .llcrypt registered [ 846.645989] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 14:55:49 (1764791749) [ 847.834506] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 847.864358] alg: No test for adler32 (adler32-zlib) [ 848.894113] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 849.022548] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 850.695131] Key type lgssc registered [ 851.785445] Lustre: Echo OBD driver; http://www.lustre.org/ [ 903.284383] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 906.242117] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 922.710161] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 928.831777] Lustre: Mounted lustre-client [ 933.879996] Lustre: lustre-OST0000-osc-ffff99bfc4ea9800: Connection to lustre-OST0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 940.785960] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 951.085153] LustreError: 31871:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 951.118491] Lustre: Unmounted lustre-client [ 984.999573] Key type lgssc unregistered [ 985.228602] LNet: 32273:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 985.239877] LNetError: 32273:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 985.267649] LNet: Removed LNI 192.168.201.5@tcp [ 985.909251] Key type .llcrypt unregistered [ 985.929146] Key type ._llcrypt unregistered [ 997.089756] Key type ._llcrypt registered [ 997.092222] Key type .llcrypt registered [ 998.158786] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 14:58:20 (1764791900) [ 999.989941] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 999.997981] alg: No test for adler32 (adler32-zlib) [ 1001.044814] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 1001.229840] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 1002.887948] Key type lgssc registered [ 1003.834716] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1051.971370] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1056.556102] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1081.340600] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1083.549811] Lustre: Mounted lustre-client [ 1088.635938] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1092.697920] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1104.955978] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2025-12-0315h00m06s [ 1108.685772] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1114.119101] Lustre: lustre-MDT0000-mdc-ffff99bfc9249000: Connection to lustre-MDT0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1120.357200] LustreError: 35977:0:(lmv_obd.c:1435:lmv_statfs()) lustre-MDT0000-mdc-ffff99bfc9249000: can't stat MDS #0: rc = -19 [ 1122.143312] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1132.521812] LustreError: MGC192.168.201.105@tcp: Connection to MGS (at 192.168.201.105@tcp) was lost; in progress operations using this service will fail [ 1132.572703] Lustre: Evicted from MGS (at 192.168.201.105@tcp) after server handle changed from 0xb1100d8daa3c3016 to 0xb1100d8daa3c32d2 [ 1132.587764] Lustre: MGC192.168.201.105@tcp: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 1133.604537] LustreError: lustre-MDT0000-mdc-ffff99bfc9249000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1133.623487] Lustre: lustre-MDT0000-mdc-ffff99bfc9249000: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 1137.432361] Lustre: DEBUG MARKER: Wait for df (35977) ... [ 1139.324641] Lustre: DEBUG MARKER: done [ 1141.444835] LustreError: 36586:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc9249000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1141.458360] LustreError: 36586:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1141.533385] Lustre: Unmounted lustre-client [ 1169.637995] Key type lgssc unregistered [ 1169.895939] LNet: 37001:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1169.906779] LNetError: 37001:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1169.932284] LNet: Removed LNI 192.168.201.5@tcp [ 1170.748994] Key type .llcrypt unregistered [ 1170.750830] Key type ._llcrypt unregistered [ 1215.238030] Key type ._llcrypt registered [ 1215.243638] Key type .llcrypt registered [ 1215.636280] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1215.664384] alg: No test for adler32 (adler32-zlib) [ 1216.886213] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 1217.102921] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 1218.847347] Key type lgssc registered [ 1221.192085] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1299.878517] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1303.290881] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1324.344776] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1366.955027] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 15:04:29 (1764792269) [ 1396.433966] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1401.318595] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1421.947692] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1424.726793] Lustre: Mounted lustre-client [ 1438.539300] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2025-12-0315h05m40s [ 1440.578591] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1449.586873] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1452.876300] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1473.503195] Lustre: 43879:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1764792357/real 1764792357] req@00000000b5160131 x1850518662029312/t0(0) o101->lustre-MDT0000-mdc-ffff99bfc5d37000@192.168.201.105@tcp:12/10 lens 576/1152 e 0 to 1 dl 1764792377 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:0 [ 1473.547124] Lustre: lustre-MDT0000-mdc-ffff99bfc5d37000: Connection to lustre-MDT0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1473.651302] Lustre: lustre-MDT0000-mdc-ffff99bfc5d37000: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 1495.608171] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1500.904535] Lustre: DEBUG MARKER: done [ 1506.616959] LustreError: 44354:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc5d37000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1506.647769] LustreError: 44354:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1506.755744] Lustre: Unmounted lustre-client [ 1535.533490] Key type lgssc unregistered [ 1535.768781] LNet: 44756:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1535.772586] LNetError: 44756:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1535.789676] LNet: Removed LNI 192.168.201.5@tcp [ 1536.419354] Key type .llcrypt unregistered [ 1536.421841] Key type ._llcrypt unregistered [ 1576.453364] Key type ._llcrypt registered [ 1576.460521] Key type .llcrypt registered [ 1576.848202] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 1576.872642] alg: No test for adler32 (adler32-zlib) [ 1578.165414] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 1578.570599] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 1580.352729] Key type lgssc registered [ 1581.846077] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1661.480768] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1664.606279] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1683.553298] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1724.967776] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 15:10:27 (1764792627) [ 1726.553200] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1728.346242] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 15:10:30 (1764792630) [ 1753.357431] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 15:10:55 (1764792655) [ 1785.135729] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1789.249234] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1807.434604] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1809.326672] Lustre: Mounted lustre-client [ 1813.296268] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1816.310158] LustreError: 52589:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd924f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1816.340570] LustreError: 52589:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1816.423101] Lustre: Unmounted lustre-client [ 1827.545725] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1877.023607] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1882.062495] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1883.297826] Lustre: Mounted lustre-client [ 1888.433968] LustreError: 53850:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc924d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1888.473477] LustreError: 53850:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1888.478667] LustreError: 53850:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1888.540944] Lustre: Unmounted lustre-client [ 1952.342937] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1955.383426] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1956.157909] Lustre: Mounted lustre-client [ 1959.152242] LustreError: 54976:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd02c1800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 1959.180405] LustreError: 54976:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 1959.183330] LustreError: 54976:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 1959.256431] Lustre: Unmounted lustre-client [ 1977.841912] Lustre: DEBUG MARKER: files compared the same [ 2004.093769] Key type lgssc unregistered [ 2004.455936] LNet: 55681:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2004.504769] LNetError: 55681:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2004.517302] LNet: Removed LNI 192.168.201.5@tcp [ 2005.206191] Key type .llcrypt unregistered [ 2005.215423] Key type ._llcrypt unregistered [ 2017.736544] Key type ._llcrypt registered [ 2017.741115] Key type .llcrypt registered [ 2018.988853] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 15:15:21 (1764792921) [ 2020.723791] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2020.747934] alg: No test for adler32 (adler32-zlib) [ 2021.721312] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2021.887553] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2023.519364] Key type lgssc registered [ 2024.403457] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2066.926996] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2070.968546] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2090.013709] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2091.762216] Lustre: Mounted lustre-client [ 2095.620511] LustreError: 58774:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd2848000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2095.652229] LustreError: 58774:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2095.722239] Lustre: Unmounted lustre-client [ 2123.407379] Key type lgssc unregistered [ 2123.682662] LNet: 59177:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2123.700835] LNetError: 59177:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2123.727087] LNet: Removed LNI 192.168.201.5@tcp [ 2124.557887] Key type .llcrypt unregistered [ 2124.559612] Key type ._llcrypt unregistered [ 2140.452847] Key type ._llcrypt registered [ 2140.454668] Key type .llcrypt registered [ 2142.135649] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 15:17:24 (1764793044) [ 2144.311308] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2144.337879] alg: No test for adler32 (adler32-zlib) [ 2145.438911] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2145.688891] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2147.383296] Key type lgssc registered [ 2148.551190] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2237.180377] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2263.838112] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2267.980416] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2315.430939] Key type lgssc unregistered [ 2315.810897] LNet: 62575:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2315.828533] LNetError: 62575:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2315.853130] LNet: Removed LNI 192.168.201.5@tcp [ 2316.712586] Key type .llcrypt unregistered [ 2316.716458] Key type ._llcrypt unregistered [ 2336.233479] Key type ._llcrypt registered [ 2336.235233] Key type .llcrypt registered [ 2337.004816] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 15:20:40 (1764793240) [ 2338.962193] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2338.983610] alg: No test for adler32 (adler32-zlib) [ 2339.902025] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2340.008719] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2341.623171] Key type lgssc registered [ 2342.134963] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2370.289645] Lustre: Mounted lustre-client [ 2375.653576] LustreError: 65055:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd2a97800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2375.663959] LustreError: 65055:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 2375.686857] Lustre: Unmounted lustre-client [ 2396.432203] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 15:21:39 (1764793299) [ 2438.141577] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2444.231794] Lustre: Mounted lustre-client [ 2449.663672] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2449.667797] LustreError: 69002:0:(file.c:249:ll_close_inode_openhandle()) lustre-clilmv-ffff99bfc5d33800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2449.678907] Lustre: 63556:0:(llite_lib.c:4237:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.201.105@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2459.946204] LustreError: 69002:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2459.949529] LustreError: 69002:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2459.967190] Lustre: Unmounted lustre-client [ 2496.096987] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 15:23:19 (1764793399) [ 2500.751518] Key type lgssc unregistered [ 2500.881135] LNet: 70210:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2500.884392] LNetError: 70210:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2500.894972] LNet: Removed LNI 192.168.201.5@tcp [ 2501.178674] Key type .llcrypt unregistered [ 2501.180212] Key type ._llcrypt unregistered [ 2505.733708] Key type ._llcrypt registered [ 2505.736418] Key type .llcrypt registered [ 2505.998629] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2506.005963] alg: No test for adler32 (adler32-zlib) [ 2506.865297] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2506.959817] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2508.551257] Key type lgssc registered [ 2508.989186] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2526.916577] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2528.159974] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2534.919020] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2545.657581] Lustre: Mounted lustre-client [ 2547.369941] LustreError: 72724:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc4eaa800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2547.378188] LustreError: 72724:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2547.400185] Lustre: Unmounted lustre-client [ 2557.333538] Key type lgssc unregistered [ 2557.461899] LNet: 73124:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2557.465412] LNetError: 73124:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2557.478696] LNet: Removed LNI 192.168.201.5@tcp [ 2557.748436] Key type .llcrypt unregistered [ 2557.749735] Key type ._llcrypt unregistered [ 2561.585767] Key type ._llcrypt registered [ 2561.587279] Key type .llcrypt registered [ 2561.836247] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2561.843466] alg: No test for adler32 (adler32-zlib) [ 2562.716170] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2562.807622] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2564.391193] Key type lgssc registered [ 2564.824277] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2615.930326] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2617.251825] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2624.022218] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2634.742891] Lustre: Mounted lustre-client [ 2635.236474] LustreError: 76061:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc8f26800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2635.245494] LustreError: 76061:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2635.273354] Lustre: Unmounted lustre-client [ 2644.884907] Key type lgssc unregistered [ 2645.016519] LNet: 76463:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2645.019071] LNetError: 76463:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2645.029381] LNet: Removed LNI 192.168.201.5@tcp [ 2645.313454] Key type .llcrypt unregistered [ 2645.314946] Key type ._llcrypt unregistered [ 2650.766581] Key type ._llcrypt registered [ 2650.767443] Key type .llcrypt registered [ 2651.294443] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 15:25:54 (1764793554) [ 2652.117589] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2652.126128] alg: No test for adler32 (adler32-zlib) [ 2652.992365] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2653.082826] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2654.671170] Key type lgssc registered [ 2655.051729] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2673.476407] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2674.794302] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2681.268443] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2693.102118] Lustre: Mounted lustre-client [ 2695.334196] LustreError: 79575:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc54d5000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2695.342091] LustreError: 79575:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2695.360646] Lustre: Unmounted lustre-client [ 2695.477984] Lustre: Mounted lustre-client [ 2696.065713] LustreError: 79653:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd2b75800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2696.072768] LustreError: 79653:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2696.075146] LustreError: 79653:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 2696.099182] Lustre: Unmounted lustre-client [ 2713.562264] Key type lgssc unregistered [ 2713.694104] LNet: 80055:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2713.697696] LNetError: 80055:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2713.706876] LNet: Removed LNI 192.168.201.5@tcp [ 2713.974725] Key type .llcrypt unregistered [ 2713.976265] Key type ._llcrypt unregistered [ 2718.366105] Key type ._llcrypt registered [ 2718.367680] Key type .llcrypt registered [ 2718.537048] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2718.542458] alg: No test for adler32 (adler32-zlib) [ 2719.402637] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2719.486973] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2721.079126] Key type lgssc registered [ 2721.486901] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2739.734410] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2741.125673] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2747.768355] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2758.131813] Lustre: Mounted lustre-client [ 2759.933959] LustreError: 82587:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc8f27000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2759.940774] LustreError: 82587:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2759.961118] Lustre: Unmounted lustre-client [ 2769.515178] Key type lgssc unregistered [ 2769.628495] LNet: 82988:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2769.631544] LNetError: 82988:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2769.640941] LNet: Removed LNI 192.168.201.5@tcp [ 2769.895749] Key type .llcrypt unregistered [ 2769.897074] Key type ._llcrypt unregistered [ 2775.235905] Key type ._llcrypt registered [ 2775.237156] Key type .llcrypt registered [ 2775.724811] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 15:27:59 (1764793679) [ 2776.570112] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2776.596331] alg: No test for adler32 (adler32-zlib) [ 2777.456562] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2777.553722] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2779.143166] Key type lgssc registered [ 2779.600247] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2798.534040] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2799.813597] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2806.305723] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2817.007480] Lustre: Mounted lustre-client [ 2821.293439] Lustre: lustre: root_squash is set to 0:0 [ 2821.302096] Lustre: lustre: nosquash_nids is cleared [ 2828.785309] Lustre: lustre: root_squash is set to 500:500 [ 2836.980566] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.201.5@tcp 192.168.0.[2,10]@tcp [ 2844.147077] Lustre: lustre: nosquash_nids set to 192.168.201.5/24@tcp [ 2844.891429] LustreError: 86477:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd2b76000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2844.902023] LustreError: 86477:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2844.924216] Lustre: Unmounted lustre-client [ 2862.748917] Key type lgssc unregistered [ 2862.882560] LNet: 86879:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2862.885284] LNetError: 86879:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2862.893656] LNet: Removed LNI 192.168.201.5@tcp [ 2863.174988] Key type .llcrypt unregistered [ 2863.176421] Key type ._llcrypt unregistered [ 2868.521525] Key type ._llcrypt registered [ 2868.522462] Key type .llcrypt registered [ 2868.987035] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 15:29:32 (1764793772) [ 2869.798809] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 2870.365248] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 15:29:33 (1764793773) [ 2871.190777] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2871.205398] alg: No test for adler32 (adler32-zlib) [ 2872.064216] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2872.157629] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2873.751208] Key type lgssc registered [ 2874.143879] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2891.822591] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2893.131656] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2899.607360] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 2899.796836] Lustre: lustre: root_squash is set to 500:500 [ 2899.803871] Lustre: lustre: nosquash_nids set to 192.168.201.5/24@tcp [ 2910.192061] Lustre: Mounted lustre-client [ 2912.604730] LustreError: 90336:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc58a4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 2912.611471] LustreError: 90336:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [ 2912.631140] Lustre: Unmounted lustre-client [ 2929.884741] Key type lgssc unregistered [ 2930.001627] LNet: 90738:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2930.005343] LNetError: 90738:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2930.020545] LNet: Removed LNI 192.168.201.5@tcp [ 2930.256952] Key type .llcrypt unregistered [ 2930.258664] Key type ._llcrypt unregistered [ 2936.175604] Key type ._llcrypt registered [ 2936.177212] Key type .llcrypt registered [ 2936.717657] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 2937.323879] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 15:30:40 (1764793840) [ 2943.890329] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2943.914671] alg: No test for adler32 (adler32-zlib) [ 2944.780039] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 2944.860671] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 2946.439181] Key type lgssc registered [ 2946.877102] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2977.596391] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 2978.926987] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 2986.705489] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3032.735503] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3033.858779] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3039.957550] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3053.231556] Lustre: Mounted lustre-client [ 3066.535700] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff99bfc54d0000.ost_server_uuid 50 [ 3067.045611] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff99bfc54d0000.ost_server_uuid in FULL state after 0 sec [ 3067.193312] Lustre: Mounted lustre-client [ 3067.957835] LustreError: 97618:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd0320800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3067.965881] LustreError: 97618:0:(obd_class.h:479:obd_check_dev()) Device 12 not setup [ 3067.995142] Lustre: Unmounted lustre-client [ 3095.885898] Key type lgssc unregistered [ 3096.009854] LNet: 98188:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3096.013487] LNetError: 98188:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3096.023168] LNet: Removed LNI 192.168.201.5@tcp [ 3096.283130] Key type .llcrypt unregistered [ 3096.284257] Key type ._llcrypt unregistered [ 3112.162366] Key type ._llcrypt registered [ 3112.163646] Key type .llcrypt registered [ 3112.380694] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3112.387660] alg: No test for adler32 (adler32-zlib) [ 3113.262822] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 3113.373338] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 3114.967227] Key type lgssc registered [ 3115.454907] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3146.614689] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3147.869991] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3155.802714] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3187.167225] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 15:34:50 (1764794090) [ 3222.710149] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3224.964353] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3240.271359] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3241.931960] Lustre: Mounted lustre-client [ 3262.433153] Lustre: 98973:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1764794150/real 1764794150] req@00000000741180e9 x1850520651175040/t0(0) o400->lustre-OST0000-osc-ffff99bfc8f27800@192.168.201.105@tcp:28/4 lens 224/224 e 0 to 1 dl 1764794166 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3262.448475] Lustre: lustre-OST0000-osc-ffff99bfc8f27800: Connection to lustre-OST0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3262.474476] Lustre: lustre-OST0000-osc-ffff99bfc8f27800: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 3267.554844] Lustre: lustre-MDT0000-mdc-ffff99bfc8f27800: Connection to lustre-MDT0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3268.575690] Lustre: 98975:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1764794156/real 1764794156] req@000000002cc12ae0 x1850520651175552/t0(0) o400->lustre-OST0000-osc-ffff99bfc8f27800@192.168.201.105@tcp:28/4 lens 224/224 e 0 to 1 dl 1764794172 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3273.695195] Lustre: 98973:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1764794161/real 1764794161] req@00000000daf0e4e6 x1850520651176064/t0(0) o400->lustre-OST0000-osc-ffff99bfc8f27800@192.168.201.105@tcp:28/4 lens 224/224 e 0 to 1 dl 1764794177 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3277.797062] LustreError: MGC192.168.201.105@tcp: Connection to MGS (at 192.168.201.105@tcp) was lost; in progress operations using this service will fail [ 3277.804714] Lustre: 106098:0:(mgc_request.c:1910:mgc_process_log()) MGC192.168.201.105@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 3277.809704] Lustre: Evicted from MGS (at 192.168.201.105@tcp) after server handle changed from 0x5a4d619531043a3d to 0x5a4d619531043ce4 [ 3277.819492] Lustre: MGC192.168.201.105@tcp: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 3282.507262] Lustre: lustre-MDT0000-mdc-ffff99bfc8f27800: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 3282.942107] LustreError: 106821:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc8f27800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3282.950358] LustreError: 106821:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3282.974200] Lustre: Unmounted lustre-client [ 3301.669684] Key type lgssc unregistered [ 3301.832490] LNet: 107221:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3301.835988] LNetError: 107221:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3301.851805] LNet: Removed LNI 192.168.201.5@tcp [ 3302.175680] Key type .llcrypt unregistered [ 3302.177665] Key type ._llcrypt unregistered [ 3308.845226] Key type ._llcrypt registered [ 3308.846431] Key type .llcrypt registered [ 3309.403774] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 15:36:52 (1764794212) [ 3321.472910] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3321.484661] alg: No test for adler32 (adler32-zlib) [ 3322.398487] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 3322.507897] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 3324.111328] Key type lgssc registered [ 3324.614409] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3340.766757] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3410.025994] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3414.112598] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3427.327917] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3428.703540] Lustre: Mounted lustre-client [ 3429.884367] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 3430.977974] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 15:38:54 (1764794334) [ 3514.634906] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3524.903194] LustreError: 117973:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3524.920158] Lustre: Unmounted lustre-client [ 3575.115136] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3576.336754] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3583.564335] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3614.596985] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 15:41:57 (1764794517) [ 3645.729400] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3646.995182] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3654.500284] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3654.673324] Lustre: Mounted lustre-client [ 3655.785823] LustreError: 125363:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc5df2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3655.792954] LustreError: 125363:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3655.794587] LustreError: 125363:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3655.818254] Lustre: Unmounted lustre-client [ 3674.472120] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 15:42:57 (1764794577) [ 3705.506869] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3706.750647] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3714.538290] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3714.695688] Lustre: Mounted lustre-client [ 3715.686900] LustreError: 129399:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc924d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3715.692290] LustreError: 129399:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3715.694303] LustreError: 129399:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 3715.713977] Lustre: Unmounted lustre-client [ 3737.954597] Key type lgssc unregistered [ 3738.130591] LNet: 129802:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3738.135473] LNetError: 129802:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3738.147805] LNet: Removed LNI 192.168.201.5@tcp [ 3738.556339] Key type .llcrypt unregistered [ 3738.558964] Key type ._llcrypt unregistered [ 3748.014112] Key type ._llcrypt registered [ 3748.015564] Key type .llcrypt registered [ 3748.779788] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 15:44:11 (1764794651) [ 3750.245191] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3750.275840] alg: No test for adler32 (adler32-zlib) [ 3751.228383] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 3751.372574] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 3753.031224] Key type lgssc registered [ 3753.956960] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3798.323474] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3800.837100] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3810.767777] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3821.562125] Lustre: Mounted lustre-client [ 3832.811560] LustreError: 132901:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc656a800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3832.822384] LustreError: 132901:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3832.859419] Lustre: Unmounted lustre-client [ 3854.242850] Key type lgssc unregistered [ 3854.405902] LNet: 133303:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3854.413602] LNetError: 133303:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3854.428636] LNet: Removed LNI 192.168.201.5@tcp [ 3854.940834] Key type .llcrypt unregistered [ 3854.946054] Key type ._llcrypt unregistered [ 3870.341233] Key type ._llcrypt registered [ 3870.348189] Key type .llcrypt registered [ 3872.164222] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 15:46:13 (1764794773) [ 3876.168567] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3876.216699] alg: No test for adler32 (adler32-zlib) [ 3877.468632] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 3877.867876] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 3879.655197] Key type lgssc registered [ 3881.935255] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3944.295741] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 3947.462208] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 3964.120933] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 3966.783086] Lustre: Mounted lustre-client [ 3972.098736] Lustre: lustre-OST0000-osc-ffff99bfc6453000: Connection to lustre-OST0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3982.349442] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff99bfc6453000.ost_server_uuid 50 [ 3983.851370] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 3994.561025] LustreError: 136851:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc6453000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 3994.592337] LustreError: 136851:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 3994.676154] Lustre: Unmounted lustre-client [ 4015.926536] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 15:48:38 (1764794918) [ 4044.030520] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4047.742772] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4062.153510] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4074.225164] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4074.496988] Lustre: Mounted lustre-client [ 4079.589590] Lustre: lustre-OST0000-osc-ffff99bfc5efb800: Connection to lustre-OST0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4104.477429] LustreError: 139507:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc5efb800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4104.486573] LustreError: 139507:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4104.489466] LustreError: 139507:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 4104.526210] Lustre: Unmounted lustre-client [ 4138.870887] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 15:50:41 (1764795041) [ 4179.341713] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4184.446927] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4203.152434] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4218.085548] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4218.640195] Lustre: Mounted lustre-client [ 4223.988145] Lustre: lustre-OST0000-osc-ffff99bfd2b71000: Connection to lustre-OST0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4239.598412] LustreError: 142264:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd2b71000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4239.612673] LustreError: 142264:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 4239.634440] LustreError: 142264:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4239.643907] LustreError: 142264:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 4239.744369] Lustre: Unmounted lustre-client [ 4293.732145] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 15:53:16 (1764795196) [ 4377.573368] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4381.565528] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4403.681282] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4478.251324] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4482.401406] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4502.968302] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4533.542467] Lustre: Mounted lustre-client [ 4575.849860] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4581.229273] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 4583.181857] LustreError: 148903:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc54d0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4583.195414] LustreError: 148903:0:(lov_obd.c:783:lov_cleanup()) Skipped 1 previous similar message [ 4583.222851] LustreError: 148903:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 4583.234306] LustreError: 148903:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 4583.342564] Lustre: Unmounted lustre-client [ 4613.855255] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 15:58:35 (1764795515) [ 4641.372522] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4646.742331] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4676.470762] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4712.399615] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4739.375169] Lustre: Mounted lustre-client [ 4779.419977] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4781.194667] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 4785.649064] Lustre: lustre-OST0001-osc-ffff99bfc5df2800: Connection to lustre-OST0001 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4792.279348] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4802.550318] LustreError: 152506:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4802.564167] LustreError: 152506:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 4802.644352] Lustre: Unmounted lustre-client [ 4860.158596] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 16:02:42 (1764795762) [ 4883.948162] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 4887.033469] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 4902.856961] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 4908.587349] Lustre: Mounted lustre-client [ 4930.441638] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 4932.143528] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 4942.958851] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff99bfc5ed0800.ost_server_uuid 50 [ 4944.402350] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff99bfc5ed0800.ost_server_uuid in FULL state after 0 sec [ 4947.281300] LustreError: 155933:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc5ed0800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 4947.296193] LustreError: 155933:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 4947.301179] LustreError: 155933:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 4947.356618] Lustre: Unmounted lustre-client [ 4947.779460] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 4947.788986] Lustre: Skipped 3 previous similar messages [ 4947.976575] Lustre: Mounted lustre-client [ 4949.468301] LustreError: 155998:0:(sec.c:410:import_sec_validate_get()) import 00000000bf1a0b8e (NEW) with no sec [ 5022.803936] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 16:05:24 (1764795924) [ 5054.656154] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5059.056124] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5079.482370] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5096.298579] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5096.770597] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5096.963469] Lustre: Mounted lustre-client [ 5107.931693] LustreError: 158849:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc5ed2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5107.935591] LustreError: 158849:0:(lov_obd.c:783:lov_cleanup()) Skipped 2 previous similar messages [ 5107.950420] LustreError: 158849:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 5107.953529] LustreError: 158849:0:(obd_class.h:479:obd_check_dev()) Skipped 18 previous similar messages [ 5108.082717] Lustre: Unmounted lustre-client [ 5108.090444] Lustre: Skipped 1 previous similar message [ 5142.575649] Key type lgssc unregistered [ 5142.867918] LNet: 159297:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5142.874992] LNetError: 159297:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5142.891065] LNet: Removed LNI 192.168.201.5@tcp [ 5143.530938] Key type .llcrypt unregistered [ 5143.532343] Key type ._llcrypt unregistered [ 5156.886258] Key type ._llcrypt registered [ 5156.889613] Key type .llcrypt registered [ 5158.297778] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 16:07:40 (1764796060) [ 5159.348256] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5159.382798] alg: No test for adler32 (adler32-zlib) [ 5160.381921] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 5160.585747] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 5162.287249] Key type lgssc registered [ 5163.228816] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5206.513232] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5209.792759] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5228.184815] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5245.686708] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5247.169182] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5248.387439] Lustre: Mounted lustre-client [ 5253.449271] LustreError: lustre-MDT0001-mdc-ffff99bfc656f000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 5253.467565] Lustre: lustre-MDT0001-mdc-ffff99bfc656f000: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 5256.306889] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5257.691743] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5273.604306] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5276.541447] LustreError: 163516:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc656f000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5276.551089] LustreError: 163516:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 5276.603460] Lustre: Unmounted lustre-client [ 5303.870876] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 16:10:06 (1764796206) [ 5384.417848] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5387.356943] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5404.145143] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5404.582990] Lustre: Mounted lustre-client [ 5425.116140] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 5426.533672] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5428.713512] Lustre: lustre-OST0001-osc-ffff99bfd02c6000: Connection to lustre-OST0001 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5446.250912] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5456.617606] LustreError: 168250:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 5456.648047] LustreError: 168250:0:(obd_class.h:479:obd_check_dev()) Skipped 9 previous similar messages [ 5456.788353] Lustre: Unmounted lustre-client [ 5488.995969] Key type lgssc unregistered [ 5489.259641] LNet: 168655:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5489.268812] LNetError: 168655:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5490.277768] LNet: Removed LNI 192.168.201.5@tcp [ 5490.879683] Key type .llcrypt unregistered [ 5490.881479] Key type ._llcrypt unregistered [ 5523.812684] Key type ._llcrypt registered [ 5523.814493] Key type .llcrypt registered [ 5524.181120] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5524.189685] alg: No test for adler32 (adler32-zlib) [ 5525.237465] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 5525.437474] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 5527.119188] Key type lgssc registered [ 5528.232822] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5604.187810] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5608.214587] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5628.989712] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5670.154363] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 16:16:12 (1764796572) [ 5699.558804] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5703.500300] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5721.183171] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5722.964440] Lustre: Mounted lustre-client [ 5770.167198] LustreError: 174752:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd02c2800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5770.188491] LustreError: 174752:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5770.257289] Lustre: Unmounted lustre-client [ 5797.414505] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5797.743893] Lustre: Mounted lustre-client [ 5831.736886] LustreError: 175412:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc6452800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5831.764486] LustreError: 175412:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5831.773868] LustreError: 175412:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 5831.834486] Lustre: Unmounted lustre-client [ 5857.983498] Key type lgssc unregistered [ 5858.237918] LNet: 175818:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5858.255904] LNetError: 175818:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5858.275325] LNet: Removed LNI 192.168.201.5@tcp [ 5858.858677] Key type .llcrypt unregistered [ 5858.861882] Key type ._llcrypt unregistered [ 5871.343220] Key type ._llcrypt registered [ 5871.345151] Key type .llcrypt registered [ 5872.493855] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 16:19:35 (1764796775) [ 5874.212604] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5874.266222] alg: No test for adler32 (adler32-zlib) [ 5875.332319] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 5875.590060] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 5877.271186] Key type lgssc registered [ 5878.574465] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5924.711990] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 5928.850571] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 5943.175900] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 5948.979851] Lustre: Mounted lustre-client [ 5964.717790] LustreError: 179085:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc58a2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 5964.743025] LustreError: 179085:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 5964.783180] Lustre: Unmounted lustre-client [ 5987.494265] Key type lgssc unregistered [ 5987.726701] LNet: 179487:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5987.732088] LNetError: 179487:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5987.742158] LNet: Removed LNI 192.168.201.5@tcp [ 5988.243906] Key type .llcrypt unregistered [ 5988.245641] Key type ._llcrypt unregistered [ 5997.202684] Key type ._llcrypt registered [ 5997.206176] Key type .llcrypt registered [ 5997.574790] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 5997.591711] alg: No test for adler32 (adler32-zlib) [ 5998.637482] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 5998.953838] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 6000.719165] Key type lgssc registered [ 6001.932690] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6048.934187] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6052.016171] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6066.749821] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6072.847895] Lustre: Mounted lustre-client [ 6078.435178] LustreError: 182059:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd0322800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6078.458590] LustreError: 182059:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6078.527182] Lustre: Unmounted lustre-client [ 6105.709852] Key type lgssc unregistered [ 6105.952098] LNet: 182461:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6105.965332] LNetError: 182461:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6105.995218] LNet: Removed LNI 192.168.201.5@tcp [ 6106.790931] Key type .llcrypt unregistered [ 6106.797919] Key type ._llcrypt unregistered [ 6120.787670] Key type ._llcrypt registered [ 6120.789291] Key type .llcrypt registered [ 6121.959697] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 16:23:44 (1764797024) [ 6124.848220] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6124.895235] alg: No test for adler32 (adler32-zlib) [ 6126.072997] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 6126.365543] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 6128.127174] Key type lgssc registered [ 6129.526482] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6172.033042] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6175.328382] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6191.519240] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6202.411992] Lustre: Mounted lustre-client [ 6222.117122] LustreError: 185725:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc54d4000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6222.144720] LustreError: 185725:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6222.220433] Lustre: Unmounted lustre-client [ 6256.512877] Key type lgssc unregistered [ 6256.762617] LNet: 186129:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6256.772694] LNetError: 186129:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6257.829700] LNet: Removed LNI 192.168.201.5@tcp [ 6258.440765] Key type .llcrypt unregistered [ 6258.444595] Key type ._llcrypt unregistered [ 6269.636953] Key type ._llcrypt registered [ 6269.638788] Key type .llcrypt registered [ 6270.119699] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6270.138763] alg: No test for adler32 (adler32-zlib) [ 6271.230079] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 6271.461943] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 6273.175863] Key type lgssc registered [ 6274.313579] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6319.189613] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6322.290328] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6339.563469] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6345.267631] Lustre: Mounted lustre-client [ 6350.943948] LustreError: 188703:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc62d0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6350.968856] LustreError: 188703:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6351.062943] Lustre: Unmounted lustre-client [ 6384.584400] Key type lgssc unregistered [ 6384.924476] LNet: 189111:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6384.938496] LNetError: 189111:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6384.962052] LNet: Removed LNI 192.168.201.5@tcp [ 6385.758517] Key type .llcrypt unregistered [ 6385.760023] Key type ._llcrypt unregistered [ 6400.810457] Key type ._llcrypt registered [ 6400.812214] Key type .llcrypt registered [ 6401.933608] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 16:28:24 (1764797304) [ 6422.294722] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6422.331569] alg: No test for adler32 (adler32-zlib) [ 6423.460964] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 6423.803795] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 6425.555518] Key type lgssc registered [ 6426.886424] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6499.914935] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6503.189811] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6521.940111] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6566.698567] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 16:31:09 (1764797469) [ 6594.935674] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6598.435592] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6614.956820] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 6620.717158] Lustre: Mounted lustre-client [ 6624.430562] LustreError: 195632:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd0cf7000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 6624.459738] LustreError: 195632:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6624.517439] Lustre: Unmounted lustre-client [ 6651.139868] Key type lgssc unregistered [ 6651.408736] LNet: 196034:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6651.422716] LNetError: 196034:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6651.448026] LNet: Removed LNI 192.168.201.5@tcp [ 6652.127080] Key type .llcrypt unregistered [ 6652.141603] Key type ._llcrypt unregistered [ 6667.167966] Key type ._llcrypt registered [ 6667.169970] Key type .llcrypt registered [ 6668.428208] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 6670.168783] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 16:32:52 (1764797572) [ 6685.110787] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6685.148558] alg: No test for adler32 (adler32-zlib) [ 6686.196584] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 6686.336144] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 6687.983172] Key type lgssc registered [ 6688.892363] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6768.353415] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6771.744900] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6788.732946] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid [ 6804.884056] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid [ 6806.584494] Lustre: Mounted lustre-client [ 6824.715801] LustreError: 201569:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc863f800: lov tgt 1000 not cleaned! deathrow=0, lovrc=1 [ 6824.744163] LustreError: 201569:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 6824.805356] Lustre: Unmounted lustre-client [ 6947.315432] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 6949.845801] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 6968.777361] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7013.857555] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 16:38:35 (1764797915) [ 7015.550467] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 7017.653703] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 16:38:39 (1764797919) [ 7075.803145] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7079.675558] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7109.008755] Key type lgssc unregistered [ 7109.408288] LNet: 207756:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7109.421058] LNetError: 207756:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7109.442655] LNet: Removed LNI 192.168.201.5@tcp [ 7110.213329] Key type .llcrypt unregistered [ 7110.215306] Key type ._llcrypt unregistered [ 7123.818592] Key type ._llcrypt registered [ 7123.820338] Key type .llcrypt registered [ 7125.089711] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 16:40:27 (1764798027) [ 7159.423272] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7159.539104] alg: No test for adler32 (adler32-zlib) [ 7160.647470] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 7160.857696] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 7162.598499] Key type lgssc registered [ 7163.916910] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7203.778664] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7206.701162] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7227.820379] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7254.033861] Key type lgssc unregistered [ 7254.222323] LNet: 211392:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7254.226473] LNetError: 211392:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7254.241554] LNet: Removed LNI 192.168.201.5@tcp [ 7254.742499] Key type .llcrypt unregistered [ 7254.745075] Key type ._llcrypt unregistered [ 7269.364246] Key type ._llcrypt registered [ 7269.365940] Key type .llcrypt registered [ 7270.545856] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 16:42:53 (1764798173) [ 7272.966490] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7273.000797] alg: No test for adler32 (adler32-zlib) [ 7274.045217] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 7274.247813] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 7275.935192] Key type lgssc registered [ 7276.984635] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7328.825942] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7333.786639] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7353.860873] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7356.172830] Lustre: Mounted lustre-client [ 7366.630591] Lustre: lustre-MDT0000-mdc-ffff99bfc41e8800: Connection to lustre-MDT0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7376.886859] Lustre: lustre-MDT0001-mdc-ffff99bfc41e8800: Connection to lustre-MDT0001 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7387.103222] Lustre: 212378:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1764798275/real 1764798275] req@0000000072d5d2a2 x1850525014376448/t0(0) o400->MGC192.168.201.105@tcp@192.168.201.105@tcp:26/25 lens 224/224 e 0 to 1 dl 1764798291 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 7387.130696] LustreError: MGC192.168.201.105@tcp: Connection to MGS (at 192.168.201.105@tcp) was lost; in progress operations using this service will fail [ 7412.788371] Lustre: Evicted from MGS (at 192.168.201.105@tcp) after server handle changed from 0x4936af490fe5a8b7 to 0x4936af490fe5c383 [ 7412.804581] Lustre: MGC192.168.201.105@tcp: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 7442.928659] LustreError: lustre-MDT0000-mdc-ffff99bfc41e8800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 7442.977785] Lustre: lustre-MDT0000-mdc-ffff99bfc41e8800: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 7444.170152] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7445.743868] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7449.363181] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7451.155220] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7454.344330] LustreError: 215809:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc41e8800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 7454.377467] LustreError: 215809:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 7454.468626] Lustre: Unmounted lustre-client [ 7491.928504] Key type lgssc unregistered [ 7492.283709] LNet: 216212:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7492.309246] LNetError: 216212:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7492.342398] LNet: Removed LNI 192.168.201.5@tcp [ 7493.100293] Key type .llcrypt unregistered [ 7493.104299] Key type ._llcrypt unregistered [ 7510.033574] Key type ._llcrypt registered [ 7510.035125] Key type .llcrypt registered [ 7511.403613] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 16:46:53 (1764798413) [ 7514.027959] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7514.044284] alg: No test for adler32 (adler32-zlib) [ 7515.095228] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 7515.260114] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 7516.919189] Key type lgssc registered [ 7518.271529] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7571.827703] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7575.600521] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7628.579768] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7634.426202] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7665.148825] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7685.602115] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 7722.255235] Key type lgssc unregistered [ 7722.534580] LNet: 221331:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7722.545536] LNetError: 221331:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7722.576700] LNet: Removed LNI 192.168.201.5@tcp [ 7723.377401] Key type .llcrypt unregistered [ 7723.380791] Key type ._llcrypt unregistered [ 7764.454857] Key type ._llcrypt registered [ 7764.460428] Key type .llcrypt registered [ 7765.127564] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7765.147569] alg: No test for adler32 (adler32-zlib) [ 7766.201592] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 7766.397269] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 7768.039804] Key type lgssc registered [ 7769.198754] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7842.401951] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 7845.552697] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 7865.926982] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 7906.575891] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 16:53:29 (1764798809) [ 8025.868254] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8030.595919] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8059.318564] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8100.307402] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 16:56:42 (1764799002) [ 8106.991576] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 16:56:49 (1764799009) [ 8134.319353] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8137.852952] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8155.963299] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8162.850683] Lustre: Mounted lustre-client [ 8167.813827] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 8169.569858] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 8170.887659] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 8172.301140] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 8178.149428] Lustre: lustre-MDT0000-mdc-ffff99bfc54d0000: Connection to lustre-MDT0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8193.514979] LustreError: MGC192.168.201.105@tcp: Connection to MGS (at 192.168.201.105@tcp) was lost; in progress operations using this service will fail [ 8193.553436] Lustre: Evicted from MGS (at 192.168.201.105@tcp) after server handle changed from 0xf65f24a9cd42e06d to 0xf65f24a9cd42e2d5 [ 8193.568721] Lustre: MGC192.168.201.105@tcp: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 8197.739163] Lustre: lustre-MDT0000-mdc-ffff99bfc54d0000: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 8201.803153] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8203.155379] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8206.884355] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 8208.869448] Lustre: lustre-MDT0000-mdc-ffff99bfc54d0000: Connection to lustre-MDT0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8224.224828] Lustre: 222120:0:(client.c:2468:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1764799112/real 1764799112] req@00000000e9caa4d2 x1850525530211072/t0(0) o400->MGC192.168.201.105@tcp@192.168.201.105@tcp:26/25 lens 224/224 e 0 to 1 dl 1764799128 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 8224.257643] LustreError: MGC192.168.201.105@tcp: Connection to MGS (at 192.168.201.105@tcp) was lost; in progress operations using this service will fail [ 8233.061588] Lustre: lustre-MDT0000-mdc-ffff99bfc54d0000: Connection restored to 192.168.201.105@tcp (at 192.168.201.105@tcp) [ 8234.501979] Lustre: Evicted from MGS (at 192.168.201.105@tcp) after server handle changed from 0xf65f24a9cd42e2d5 to 0xf65f24a9cd42e6cc [ 8238.852550] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8240.303893] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8243.177324] LustreError: 234966:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc54d0000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8243.198296] LustreError: 234966:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8243.263329] Lustre: Unmounted lustre-client [ 8317.843931] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8321.957976] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8349.470739] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8350.292092] Lustre: Mounted lustre-client [ 8352.136085] LustreError: 236591:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc745d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8352.168750] LustreError: 236591:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8352.171883] LustreError: 236591:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 8352.240284] Lustre: Unmounted lustre-client [ 8383.142456] Key type lgssc unregistered [ 8383.396169] LNet: 237004:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8383.403121] LNetError: 237004:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8383.424119] LNet: Removed LNI 192.168.201.5@tcp [ 8384.053398] Key type .llcrypt unregistered [ 8384.055184] Key type ._llcrypt unregistered [ 8399.770301] Key type ._llcrypt registered [ 8399.776984] Key type .llcrypt registered [ 8401.212862] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 17:01:43 (1764799303) [ 8405.451122] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8405.602328] alg: No test for adler32 (adler32-zlib) [ 8406.819412] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 8407.028416] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 8408.802351] Key type lgssc registered [ 8410.229768] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8461.539149] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8466.169334] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8484.284529] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8486.132078] Lustre: Mounted lustre-client [ 8491.205182] LustreError: 240180:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc41ed000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8491.232392] LustreError: 240180:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8491.289252] Lustre: Unmounted lustre-client [ 8555.405479] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8559.557214] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8578.966403] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8579.780781] Lustre: Mounted lustre-client [ 8590.402671] LustreError: 241783:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc3ef2000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8590.466957] LustreError: 241783:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8590.479712] LustreError: 241783:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 8590.609454] Lustre: Unmounted lustre-client [ 8654.393766] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8658.378719] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8676.684395] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8683.162163] Lustre: Mounted lustre-client [ 8685.981971] LustreError: 243401:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc755e800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 8686.026525] LustreError: 243401:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 8686.048244] LustreError: 243401:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 8686.151633] Lustre: Unmounted lustre-client [ 8713.513504] Key type lgssc unregistered [ 8713.822924] LNet: 243803:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8713.829616] LNetError: 243803:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8713.849575] LNet: Removed LNI 192.168.201.5@tcp [ 8714.602128] Key type .llcrypt unregistered [ 8714.603844] Key type ._llcrypt unregistered [ 8729.792385] Key type ._llcrypt registered [ 8729.794841] Key type .llcrypt registered [ 8731.221219] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 17:07:13 (1764799633) [ 8734.343628] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8734.369461] alg: No test for adler32 (adler32-zlib) [ 8735.560578] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 8735.862214] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 8737.535218] Key type lgssc registered [ 8738.968759] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8782.242372] Key type lgssc unregistered [ 8782.543674] LNet: 246119:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8782.562035] LNetError: 246119:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8782.589181] LNet: Removed LNI 192.168.201.5@tcp [ 8783.523063] Key type .llcrypt unregistered [ 8783.524659] Key type ._llcrypt unregistered [ 8809.740333] Key type ._llcrypt registered [ 8809.742699] Key type .llcrypt registered [ 8810.102048] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8810.125555] alg: No test for adler32 (adler32-zlib) [ 8811.244310] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 8811.513229] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 8813.255854] Key type lgssc registered [ 8814.687954] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8881.822534] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8886.053948] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 8906.554948] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 8946.700930] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 8948.411580] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 17:10:50 (1764799850) [ 8977.283903] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 8981.069737] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9001.558236] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9023.667763] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid [ 9025.517091] Lustre: Mounted lustre-client [ 9030.641209] Lustre: lustre-OST0001-osc-ffff99bfc8f24000: Connection to lustre-OST0001 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9037.922292] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9048.179406] LustreError: 252618:0:(obd_class.h:479:obd_check_dev()) Device 6 not setup [ 9048.263203] Lustre: Unmounted lustre-client [ 9100.520452] Key type lgssc unregistered [ 9100.820842] LNet: 253027:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9100.836578] LNetError: 253027:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9101.867576] LNet: Removed LNI 192.168.201.5@tcp [ 9102.459625] Key type .llcrypt unregistered [ 9102.461326] Key type ._llcrypt unregistered [ 9147.957117] Key type ._llcrypt registered [ 9147.965925] Key type .llcrypt registered [ 9148.444278] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9148.469880] alg: No test for adler32 (adler32-zlib) [ 9149.544201] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 9149.825034] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 9151.543245] Key type lgssc registered [ 9152.841761] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9227.459524] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9231.840722] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9251.847441] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9293.261204] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 17:16:35 (1764800195) [ 9338.299974] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9342.676627] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9367.644936] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 17:17:49 (1764800269) [ 9398.747696] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9402.216107] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9421.723629] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9423.540903] Lustre: Mounted lustre-client [ 9430.419341] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 9438.972196] LustreError: 260865:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9439.045121] Lustre: Unmounted lustre-client [ 9531.544615] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9534.829129] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9580.545705] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9581.191725] Lustre: Mounted lustre-client [ 9582.504648] LustreError: 262926:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc755d000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9582.527175] LustreError: 262926:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9582.536457] LustreError: 262926:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [ 9582.643517] Lustre: Unmounted lustre-client [ 9606.990477] Key type lgssc unregistered [ 9607.183070] LNet: 263329:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9607.191437] LNetError: 263329:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9608.231086] LNet: Removed LNI 192.168.201.5@tcp [ 9608.645276] Key type .llcrypt unregistered [ 9608.647124] Key type ._llcrypt unregistered [ 9631.331552] Key type ._llcrypt registered [ 9631.342748] Key type .llcrypt registered [ 9631.969516] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9631.995202] alg: No test for adler32 (adler32-zlib) [ 9633.030168] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 9633.235252] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 9634.879275] Key type lgssc registered [ 9636.517666] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9714.932113] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9717.902152] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9735.401538] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9783.499660] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 9785.053446] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 17:24:47 (1764800687) [ 9811.849426] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 9815.733618] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 9830.885645] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9839.196554] Lustre: Mounted lustre-client [ 9842.113836] LustreError: 269389:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc755f800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9842.136381] LustreError: 269389:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9842.201036] Lustre: Unmounted lustre-client [ 9877.959964] Key type lgssc unregistered [ 9878.214498] LNet: 269791:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9878.227660] LNetError: 269791:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9878.242651] LNet: Removed LNI 192.168.201.5@tcp [ 9878.858210] Key type .llcrypt unregistered [ 9878.861552] Key type ._llcrypt unregistered [ 9893.835528] Key type ._llcrypt registered [ 9893.837274] Key type .llcrypt registered [ 9895.023654] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 9896.573372] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 17:26:39 (1764800799) [ 9905.306407] Key type .llcrypt unregistered [ 9905.307978] Key type ._llcrypt unregistered [ 9912.269765] Key type ._llcrypt registered [ 9912.271294] Key type .llcrypt registered [ 9912.543343] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9912.566640] alg: No test for adler32 (adler32-zlib) [ 9913.639348] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [ 9913.829209] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [ 9915.479209] Key type lgssc registered [ 9916.589346] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9957.029320] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 9969.961436] Lustre: Mounted lustre-client [ 9972.030087] LustreError: 272803:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc5cfc800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [ 9972.048314] LustreError: 272803:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [ 9972.099712] Lustre: Unmounted lustre-client [10006.262934] Key type lgssc unregistered [10006.558870] LNet: 273205:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10006.590358] LNetError: 273205:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10006.610250] LNet: Removed LNI 192.168.201.5@tcp [10007.278981] Key type .llcrypt unregistered [10007.281166] Key type ._llcrypt unregistered [10022.288699] Key type ._llcrypt registered [10022.290407] Key type .llcrypt registered [10023.756739] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 17:28:46 (1764800926) [10026.101392] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10026.201689] alg: No test for adler32 (adler32-zlib) [10027.377410] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [10027.684360] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [10029.423249] Key type lgssc registered [10031.390541] Lustre: Echo OBD driver; http://www.lustre.org/ [10114.289057] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10144.613347] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10149.250836] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10151.971114] Lustre: Mounted lustre-client [10154.133193] LustreError: 276253:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc3ef3800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10154.154617] LustreError: 276253:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10154.211900] Lustre: Unmounted lustre-client [10189.912714] Key type lgssc unregistered [10190.291973] LNet: 276657:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10190.312967] LNetError: 276657:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10190.339449] LNet: Removed LNI 192.168.201.5@tcp [10190.981133] Key type .llcrypt unregistered [10190.982982] Key type ._llcrypt unregistered [10207.879864] Key type ._llcrypt registered [10207.886317] Key type .llcrypt registered [10209.494803] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 17:31:51 (1764801111) [10212.140950] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10212.183856] alg: No test for adler32 (adler32-zlib) [10213.411868] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [10213.746398] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [10215.423189] Key type lgssc registered [10217.132065] Lustre: Echo OBD driver; http://www.lustre.org/ [10263.808417] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10268.607959] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10288.437906] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10291.338996] Lustre: Mounted lustre-client [10296.817997] Lustre: lustre-MDT0000-mdc-ffff99bfc9249000: Connection to lustre-MDT0000 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [10298.356441] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10298.411437] LustreError: 279729:0:(file.c:6118:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [10298.809336] LustreError: 279748:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc9249000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10298.845630] LustreError: 279748:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10298.850105] LustreError: MGC192.168.201.105@tcp: Connection to MGS (at 192.168.201.105@tcp) was lost; in progress operations using this service will fail [10298.896753] Lustre: Unmounted lustre-client [10320.971498] Key type lgssc unregistered [10321.343671] LNet: 280141:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10321.354928] LNetError: 280141:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10321.374252] LNet: Removed LNI 192.168.201.5@tcp [10322.159370] Key type .llcrypt unregistered [10322.163493] Key type ._llcrypt unregistered [10339.629355] Key type ._llcrypt registered [10339.631478] Key type .llcrypt registered [10341.376835] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 17:34:03 (1764801243) [10344.183882] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10344.379798] alg: No test for adler32 (adler32-zlib) [10345.495639] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [10345.773287] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [10347.545625] Key type lgssc registered [10348.864730] Lustre: Echo OBD driver; http://www.lustre.org/ [10391.768353] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10396.247477] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10412.966480] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10419.767798] Lustre: Mounted lustre-client [10424.823494] Lustre: lustre-MDT0001-mdc-ffff99bfd2848000: Connection to lustre-MDT0001 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [10430.107500] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [10431.383778] LustreError: 283239:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd2848000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10431.412968] LustreError: 283239:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10431.470317] Lustre: Unmounted lustre-client [10450.101610] Key type lgssc unregistered [10450.303887] LNet: 283632:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10450.312733] LNetError: 283632:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10450.331387] LNet: Removed LNI 192.168.201.5@tcp [10450.925580] Key type .llcrypt unregistered [10450.930733] Key type ._llcrypt unregistered [10465.045352] Key type ._llcrypt registered [10465.055685] Key type .llcrypt registered [10466.776782] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 17:36:08 (1764801368) [10483.300878] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10483.329153] alg: No test for adler32 (adler32-zlib) [10484.392579] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [10484.593118] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [10486.306392] Key type lgssc registered [10487.598932] Lustre: Echo OBD driver; http://www.lustre.org/ [10590.372906] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10593.117136] Lustre: Mounted lustre-client [10628.067472] Lustre: lustre-MDT0001-mdc-ffff99bfc8f22800: Connection to lustre-MDT0001 (at 192.168.201.105@tcp) was lost; in progress operations using this service will wait for recovery to complete [10636.091673] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10646.403095] LustreError: 288984:0:(obd_class.h:479:obd_check_dev()) Device 4 not setup [10646.440931] Lustre: Unmounted lustre-client [10672.649498] Key type lgssc unregistered [10672.869395] LNet: 289385:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10672.882517] LNetError: 289385:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [10672.900906] LNet: Removed LNI 192.168.201.5@tcp [10673.660475] Key type .llcrypt unregistered [10673.666943] Key type ._llcrypt unregistered [10689.233773] Key type ._llcrypt registered [10689.237243] Key type .llcrypt registered [10690.848830] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 17:39:52 (1764801592) [10693.003923] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [10695.229001] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 17:39:57 (1764801597) [10696.748566] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [10698.455656] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 17:40:00 (1764801600) [10700.031326] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [10701.629124] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 17:40:04 (1764801604) [10703.259553] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [10705.137886] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 17:40:07 (1764801607) [10706.697926] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [10708.387992] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 17:40:11 (1764801611) [10716.301589] Key type .llcrypt unregistered [10716.308610] Key type ._llcrypt unregistered [10723.494481] Key type ._llcrypt registered [10723.496103] Key type .llcrypt registered [10723.752548] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10723.783291] alg: No test for adler32 (adler32-zlib) [10724.936681] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [10725.235798] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [10726.903195] Key type lgssc registered [10728.333099] Lustre: Echo OBD driver; http://www.lustre.org/ [10796.543857] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10800.665421] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10819.420482] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10820.980518] Lustre: Mounted lustre-client [10822.613780] LustreError: 294977:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc5cfb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10822.655985] LustreError: 294977:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10822.764933] Lustre: Unmounted lustre-client [10860.479882] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 17:42:42 (1764801762) [10889.667258] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [10893.276593] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [10911.066717] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [10916.917820] Lustre: Mounted lustre-client [10918.547083] LustreError: 297093:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfd0320800: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [10918.568560] LustreError: 297093:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [10918.580674] LustreError: 297093:0:(obd_class.h:479:obd_check_dev()) Skipped 7 previous similar messages [10918.668802] Lustre: Unmounted lustre-client [10965.613469] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 17:44:28 (1764801868) [11045.240560] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11049.046088] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11070.956879] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11150.265490] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 17:47:33 (1764802053) [11159.111797] Key type lgssc unregistered [11159.339240] LNet: 302558:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11159.344248] LNetError: 302558:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11159.359852] LNet: Removed LNI 192.168.201.5@tcp [11159.832528] Key type .llcrypt unregistered [11159.834738] Key type ._llcrypt unregistered [11191.959890] Key type ._llcrypt registered [11191.965743] Key type .llcrypt registered [11192.642094] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11192.675815] alg: No test for adler32 (adler32-zlib) [11193.785731] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [11193.997230] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [11195.639199] Key type lgssc registered [11196.766275] Lustre: Echo OBD driver; http://www.lustre.org/ [11214.633079] Lustre: DEBUG MARKER: SKIP: conf-sanity test_73c unable to configure net [11223.848710] Key type lgssc unregistered [11224.061639] LNet: 304227:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11224.071921] LNetError: 304227:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11224.086899] LNet: Removed LNI 192.168.201.5@tcp [11224.549148] Key type .llcrypt unregistered [11224.551625] Key type ._llcrypt unregistered [11232.294076] Key type ._llcrypt registered [11232.295783] Key type .llcrypt registered [11233.438592] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 17:48:56 (1764802136) [11251.652568] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11251.687895] alg: No test for adler32 (adler32-zlib) [11252.788491] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [11253.050692] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [11254.719215] Key type lgssc registered [11255.722951] Lustre: Echo OBD driver; http://www.lustre.org/ [11303.366413] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 17:50:05 (1764802205) [11314.353456] Key type lgssc unregistered [11314.601467] LNet: 307777:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11314.605850] LNetError: 307777:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11314.628887] LNet: Removed LNI 192.168.201.5@tcp [11315.200797] Key type .llcrypt unregistered [11315.208124] Key type ._llcrypt unregistered [11324.377616] Key type ._llcrypt registered [11324.507734] Key type .llcrypt registered [11324.772459] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11324.788248] alg: No test for adler32 (adler32-zlib) [11325.858473] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [11326.186657] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [11327.919528] Key type lgssc registered [11329.267859] Lustre: Echo OBD driver; http://www.lustre.org/ [11374.707951] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11377.451942] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11397.367494] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11406.660303] LNet: Added LNI 192.168.201.5@tcp42 [8/256/0/180] [11408.653492] LNet: Removed LNI 192.168.201.5@tcp [11410.685106] Lustre: 310677:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff99bfc7458000: config has no valid NIDs, force dynamic NIDs [11411.902403] Lustre: Mounted lustre-client [11411.975980] LustreError: 310693:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc7458000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11412.001042] LustreError: 310693:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [11412.062608] Lustre: Unmounted lustre-client [11448.787838] Key type lgssc unregistered [11449.020100] LNet: 311532:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11449.029251] LNetError: 311532:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11449.041354] LNet: Removed LNI 192.168.201.5@tcp42 [11449.397372] Key type .llcrypt unregistered [11449.399212] Key type ._llcrypt unregistered [11456.189344] Key type ._llcrypt registered [11456.191108] Key type .llcrypt registered [11457.322881] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 17:52:39 (1764802359) [11458.939651] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11458.997048] alg: No test for adler32 (adler32-zlib) [11460.058954] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [11460.262656] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [11461.921177] Key type lgssc registered [11462.893430] Lustre: Echo OBD driver; http://www.lustre.org/ [11499.414733] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11502.269311] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11521.090580] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11527.200496] Lustre: Mounted lustre-client [11581.909195] Lustre: Mounted fs15246-client [11593.512655] LustreError: 315669:0:(lov_obd.c:783:lov_cleanup()) fs15246-clilov-ffff99bfc41eb000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11593.543274] LustreError: 315669:0:(obd_class.h:479:obd_check_dev()) Device 8 not setup [11593.585526] Lustre: Unmounted fs15246-client [11618.457807] LustreError: 315886:0:(lov_obd.c:783:lov_cleanup()) lustre-clilov-ffff99bfc5c56000: lov tgt 0 not cleaned! deathrow=0, lovrc=1 [11618.470740] LustreError: 315886:0:(obd_class.h:479:obd_check_dev()) Device 5 not setup [11618.478824] LustreError: 315886:0:(obd_class.h:479:obd_check_dev()) Skipped 3 previous similar messages [11618.576963] Lustre: Unmounted lustre-client [11654.527655] Key type lgssc unregistered [11654.857686] LNet: 316289:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11654.872764] LNetError: 316289:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11654.902817] LNet: Removed LNI 192.168.201.5@tcp [11655.763634] Key type .llcrypt unregistered [11655.774575] Key type ._llcrypt unregistered [11665.537662] Key type ._llcrypt registered [11665.539299] Key type .llcrypt registered [11666.922416] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 17:56:09 (1764802569) [11668.449303] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11668.500056] alg: No test for adler32 (adler32-zlib) [11669.736742] Lustre: Lustre: Build Version: 2.16.59_23_g5b5e124 [11670.052292] LNet: Added LNI 192.168.201.5@tcp [8/256/0/180] [11671.743261] Key type lgssc registered [11673.170565] Lustre: Echo OBD driver; http://www.lustre.org/ [11796.754263] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [11800.164418] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [11817.189863] Lustre: DEBUG MARKER: oleg105-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [11905.934256] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 11754 sec ========= 18:00:08 (1764802808) [11907.812823] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 18:00:10 (1764802810) === [11911.449159] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 18:00:13 (1764802813) === [11939.066656] Key type lgssc unregistered [11939.431623] LNet: 325449:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11939.439078] LNetError: 325449:0:(acceptor.c:264:lnet_acceptor_remove_socket()) Interface ens2 not found [11939.452231] LNet: Removed LNI 192.168.201.5@tcp [11940.098587] Key type .llcrypt unregistered [11940.102312] Key type ._llcrypt unregistered