[ 0.000000] Linux version 4.18.0rh8.10-debug (green@maintenance) (gcc version 8.5.0 20210514 (Red Hat 8.5.0-26) (GCC)) #2 SMP Mon Jul 14 01:24:22 EDT 2025 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] signal: max sigframe size: 1776 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffd9fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffda000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000146dfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.17.0-10.fc44 06/10/2025 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 697915643 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001012] APIC: Switch to symmetric I/O mode setup [ 0.002000] x2apic enabled [ 0.002014] Switched APIC routing to physical x2apic. [ 0.003016] kvm-guest: setup PV IPIs [ 0.006627] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007026] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008016] pid_max: default: 32768 minimum: 301 [ 0.009169] LSM: Security Framework initializing [ 0.011025] Yama: becoming mindful. [ 0.012058] SELinux: Initializing. [ 0.013065] *** VALIDATE selinux *** [ 0.022682] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027579] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028210] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029133] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030122] *** VALIDATE tmpfs *** [ 0.032127] *** VALIDATE proc *** [ 0.034355] *** VALIDATE cgroup *** [ 0.035021] *** VALIDATE cgroup2 *** [ 0.037044] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038168] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.039013] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.040026] Spectre V2 : User space: Vulnerable [ 0.041004] Speculative Store Bypass: Vulnerable [ 0.044534] debug: unmapping init [mem 0xffffffff86059000-0xffffffff86060fff] [ 0.047000] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.047745] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.048018] ... version: 2 [ 0.048893] ... bit width: 48 [ 0.049010] ... generic registers: 4 [ 0.049905] ... value mask: 0000ffffffffffff [ 0.050012] ... max period: 00007fffffffffff [ 0.051008] ... fixed-purpose events: 3 [ 0.052008] ... event mask: 000000070000000f [ 0.054091] rcu: Hierarchical SRCU implementation. [ 0.057299] smp: Bringing up secondary CPUs ... [ 0.059531] x86: Booting SMP configuration: [ 0.060026] .... node #0, CPUs: #1 #2 #3 [ 0.074160] smp: Brought up 1 node, 4 CPUs [ 0.076042] smpboot: Max logical packages: 1 [ 0.077024] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.179207] node 0 deferred pages initialised in 100ms [ 0.256030] devtmpfs: initialized [ 0.257259] x86/mm: Memory block size: 128MB [ 0.260575] gcov: version magic: 0x41383552 [ 0.263351] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.267093] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.269573] pinctrl core: initialized pinctrl subsystem [ 0.272252] [ 0.272998] ************************************************************* [ 0.276018] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.281016] ** ** [ 0.283014] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.284000] ** ** [ 0.284000] ** This means that this kernel is built to expose internal ** [ 0.286015] ** IOMMU data structures, which may compromise security on ** [ 0.287000] ** your system. ** [ 0.289026] ** ** [ 0.292013] ** If you see this message and you are not debugging the ** [ 0.293012] ** kernel, report this immediately to your vendor! ** [ 0.294000] ** ** [ 0.294000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.294000] ************************************************************* [ 0.294000] NET: Registered protocol family 16 [ 0.294000] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.299063] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.300000] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.305726] cpuidle: using governor menu [ 0.308503] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.311695] PCI: Using configuration type 1 for base access [ 0.314134] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.332214] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.338127] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.344088] cryptd: max_cpu_qlen set to 1000 [ 0.348414] ACPI: Added _OSI(Module Device) [ 0.351181] ACPI: Added _OSI(Processor Device) [ 0.354021] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.358530] ACPI: Added _OSI(Processor Aggregator Device) [ 0.367671] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.380597] ACPI: Interpreter enabled [ 0.382208] ACPI: PM: (supports S0 S3 S4 S5) [ 0.384011] ACPI: Using IOAPIC for interrupt routing [ 0.387118] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.392624] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.406072] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.408041] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.412024] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.416096] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.422899] acpiphp: Slot [2] registered [ 0.425135] acpiphp: Slot [5] registered [ 0.426255] acpiphp: Slot [6] registered [ 0.428147] acpiphp: Slot [3] registered [ 0.430103] acpiphp: Slot [4] registered [ 0.432297] acpiphp: Slot [7] registered [ 0.434094] acpiphp: Slot [8] registered [ 0.435097] acpiphp: Slot [9] registered [ 0.437271] acpiphp: Slot [10] registered [ 0.439231] acpiphp: Slot [11] registered [ 0.441103] acpiphp: Slot [12] registered [ 0.443090] acpiphp: Slot [13] registered [ 0.445093] acpiphp: Slot [14] registered [ 0.447171] acpiphp: Slot [15] registered [ 0.448244] acpiphp: Slot [16] registered [ 0.450110] acpiphp: Slot [17] registered [ 0.453122] acpiphp: Slot [18] registered [ 0.457130] acpiphp: Slot [19] registered [ 0.459160] acpiphp: Slot [20] registered [ 0.462104] acpiphp: Slot [21] registered [ 0.464110] acpiphp: Slot [22] registered [ 0.466109] acpiphp: Slot [23] registered [ 0.468145] acpiphp: Slot [24] registered [ 0.469322] acpiphp: Slot [25] registered [ 0.472122] acpiphp: Slot [26] registered [ 0.474131] acpiphp: Slot [27] registered [ 0.475089] acpiphp: Slot [28] registered [ 0.477127] acpiphp: Slot [29] registered [ 0.478229] acpiphp: Slot [30] registered [ 0.480105] acpiphp: Slot [31] registered [ 0.481063] PCI host bridge to bus 0000:00 [ 0.483020] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.487031] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.490026] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.493021] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.497022] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.500025] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.502417] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.507781] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.511692] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.524016] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.529303] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.533017] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.536019] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.540024] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.544198] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.549121] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.553131] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.558318] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.565513] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.581013] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.587749] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.600069] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.641025] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.657015] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.724029] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.745599] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.759025] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.778031] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.797026] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.811030] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.813449] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.816397] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.818485] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.821343] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.826261] iommu: Default domain type: Passthrough [ 0.828534] SCSI subsystem initialized [ 0.830301] ACPI: bus type USB registered [ 0.831252] usbcore: registered new interface driver usbfs [ 0.833224] usbcore: registered new interface driver hub [ 0.835087] usbcore: registered new device driver usb [ 0.837156] pps_core: LinuxPPS API ver. 1 registered [ 0.839008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.842075] PTP clock support registered [ 0.845058] EDAC MC: Ver: 3.0.0 [ 0.847590] PCI: Using ACPI for IRQ routing [ 0.849250] NetLabel: Initializing [ 0.850007] NetLabel: domain hash size = 128 [ 0.852013] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.853060] NetLabel: unlabeled traffic allowed by default [ 0.855116] vgaarb: loaded [ 0.858520] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.860012] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.866435] clocksource: Switched to clocksource kvm-clock [ 1.004727] VFS: Disk quotas dquot_6.6.0 [ 1.007134] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 1.010737] *** VALIDATE ramfs *** [ 1.012077] *** VALIDATE hugetlbfs *** [ 1.014084] pnp: PnP ACPI init [ 1.017173] pnp: PnP ACPI: found 6 devices [ 1.032316] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 1.036642] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 1.038123] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 1.039873] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 1.043741] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 1.045873] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 1.047818] NET: Registered protocol family 2 [ 1.050396] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 1.055033] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 1.058535] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 1.063607] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 1.068038] TCP: Hash tables configured (established 65536 bind 65536) [ 1.071242] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 1.073573] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.076220] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 1.079001] NET: Registered protocol family 1 [ 1.081605] RPC: Registered named UNIX socket transport module. [ 1.083504] RPC: Registered udp transport module. [ 1.084874] RPC: Registered tcp transport module. [ 1.086604] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.089136] NET: Registered protocol family 44 [ 1.090791] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.093069] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.095126] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.097624] PCI: CLS 0 bytes, default 64 [ 1.100176] Unpacking initramfs... [ 3.149073] debug: unmapping init [mem 0xffff99de7cc64000-0xffff99de7ffcffff] [ 3.183858] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 3.187428] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 3.341261] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 6.268894] Initialise system trusted keyrings [ 6.272934] Key type blacklist registered [ 6.288676] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 6.317919] zbud: loaded [ 6.322287] *** VALIDATE nfs *** [ 6.324616] *** VALIDATE nfs4 *** [ 6.329068] pstore: using deflate compression [ 6.384634] Platform Keyring initialized [ 6.598220] NET: Registered protocol family 38 [ 6.600174] Key type asymmetric registered [ 6.601925] Asymmetric key parser 'x509' registered [ 6.635887] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 6.832993] io scheduler mq-deadline registered [ 6.836039] io scheduler kyber registered [ 6.838432] io scheduler bfq registered [ 6.841535] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 6.845539] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 6.850787] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 6.854980] ACPI: Power Button [PWRF] [ 6.861273] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 6.868507] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 6.887496] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 6.926178] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 6.964140] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 6.971710] Non-volatile memory driver v1.3 [ 6.975353] Linux agpgart interface v0.103 [ 7.140605] virtio_blk virtio1: [vda] 150000 512-byte logical blocks (76.8 MB/73.2 MiB) [ 7.151937] vda: detected capacity change from 0 to 76800000 [ 7.194654] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 7.199265] vdb: detected capacity change from 0 to 1073741824 [ 7.209811] libphy: Fixed MDIO Bus: probed [ 7.256754] usbcore: registered new interface driver usbserial_generic [ 7.265014] usbserial: USB Serial support registered for generic [ 7.274780] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 7.462379] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 7.470559] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 7.474252] mousedev: PS/2 mouse device common for all mice [ 7.479497] rtc_cmos 00:05: RTC can wake from S4 [ 7.483611] rtc_cmos 00:05: registered as rtc0 [ 7.485825] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 7.488881] intel_pstate: CPU model not supported [ 7.491835] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 7.494403] hid: raw HID events driver (C) Jiri Kosina [ 7.501515] usbcore: registered new interface driver usbhid [ 7.503625] usbhid: USB HID core driver [ 7.505590] drop_monitor: Initializing network drop monitor service [ 7.508310] Initializing XFRM netlink socket [ 7.806428] NET: Registered protocol family 10 [ 7.819509] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 7.835632] Segment Routing with IPv6 [ 7.839763] NET: Registered protocol family 17 [ 7.842220] mpls_gso: MPLS GSO support [ 7.850897] RAS: Correctable Errors collector initialized. [ 7.853453] AVX version of gcm_enc/dec engaged. [ 7.854756] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 7.858359] AES CTR mode by8 optimization enabled [ 8.350593] sched_clock: Marking stable (8350546157, 0)->(9743467223, -1392921066) [ 8.357811] registered taskstats version 1 [ 8.360302] Loading compiled-in X.509 certificates [ 8.364142] zswap: loaded using pool lzo/zbud [ 8.399685] Key type big_key registered [ 8.460105] Key type encrypted registered [ 8.464811] ima: No TPM chip found, activating TPM-bypass! [ 8.472778] ima: Allocated hash algorithm: sha1 [ 8.476404] ima: No architecture policies found [ 8.482566] evm: Initialising EVM extended attributes: [ 8.489435] evm: security.selinux [ 8.493647] evm: security.ima [ 8.498117] evm: security.capability [ 8.502615] evm: HMAC attrs: 0x1 [ 8.509677] rtc_cmos 00:05: setting system clock to 2026-09-17 08:49:41 UTC (1789634981) [ 8.528894] debug: unmapping init [mem 0xffffffff87003000-0xffffffff871fffff] [ 8.540140] debug: unmapping init [mem 0xffffffff85d82000-0xffffffff86058fff] [ 8.557070] Write protecting the kernel read-only data: 28672k [ 8.569612] debug: unmapping init [mem 0xffffffff84403000-0xffffffff845fffff] [ 8.577592] debug: unmapping init [mem 0xffffffff84d14000-0xffffffff84dfffff] [ 8.759795] hrtimer: interrupt took 31029324 ns [ 8.824987] 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) [ 8.834443] systemd[1]: Detected virtualization kvm. [ 8.836526] systemd[1]: Detected architecture x86-64. [ 8.838947] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 8.868767] systemd[1]: No hostname configured. [ 8.870662] systemd[1]: Set hostname to . [ 8.873064] random: systemd: uninitialized urandom read (16 bytes read) [ 8.875853] systemd[1]: Initializing machine ID from random generator. [ 10.256885] random: systemd: uninitialized urandom read (16 bytes read) [ 10.260211] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 10.331504] random: systemd: uninitialized urandom read (16 bytes read) [ 10.333969] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 10.338379] random: systemd: uninitialized urandom read (16 bytes read) [ 10.341577] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... Starting Journal Service... [ OK ] Reached target Sockets. Starting Setup Virtual Console... Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Reached target Local Encrypted Volumes. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 11.602423] device-mapper: uevent: version 1.0.3 [ 11.623905] 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. [ 13.006566] random: fast init done Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 13.189413] virtio_net virtio0 ens2: renamed from eth0 [ 14.188073] scsi host0: ata_piix [ 14.207274] scsi host1: ata_piix [ 14.211870] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 14.215616] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 24.233957] random: crng init done [ 24.236626] random: 6 urandom warning(s) missed due to ratelimiting [ 28.158679] dracut-initqueue[587]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 30.536302] 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... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ 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 target Timers. [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local File Systems. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ 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... [ 33.843289] printk: systemd: 26 output lines suppressed due to ratelimiting [ 35.319556] SELinux: Disabled at runtime. [ 35.499743] 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) [ 35.526408] systemd[1]: Detected virtualization kvm. [ 35.533172] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 37.801977] systemd[1]: initrd-switch-root.service: Succeeded. [ 37.820495] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 37.849239] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 37.863283] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 37.868203] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 37.888471] systemd[1]: Starting Journal Service... Starting Journal Service... [ 37.899287] systemd[1]: Mounting Kernel Debug File System... Mounting Kernel Debug File System... [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Control Socket. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-getty.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Starting Remount Root and Kernel File Systems... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Created slice system-serial\x2dgetty.slice. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... Starting Apply Kernel Variables... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ 38.410869] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. Mounting Huge Pages File System... Mounting POSIX Message Queue File System... [ OK ] Reached target Paths. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Journal Service. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 40.110421] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 41.980722] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 42.300517] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 43.143627] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 43.245907] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (8s / no limit) [** ] A start job is running for Configur…-only root support (9s / no limit) [*** ] A start job is running for Configur…-only root support (9s / no limit) [ *** ] A start job is running for Configur…only root support (10s / no limit) [ *** ] A start job is running for Configur…only root support (10s / no limit) [ ***] A start job is running for Configur…only root support (11s / no limit) [ **] A start job is running for Configur…only root support (11s / no limit)[ 49.904961] Key type dns_resolver registered [ *] A start job is running for Configur…only root support (12s / no limit) [ **] A start job is running for Configur…only root support (12s / no limit) [ ***] A start job is running for Configur…only root support (13s / no limit)[ 51.309655] NFS: Registering the id_resolver key type [ 51.323674] Key type id_resolver registered [ 51.343150] Key type id_legacy registered [ *** ] A start job is running for Configur…only root support (13s / no limit) [ *** ] A start job is running for Configur…only root support (14s / no limit) [*** ] A start job is running for Configur…only root support (14s / no limit) [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Load/Save Random Seed. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Reached target sshd-keygen.target. [ OK ] Started dnf makecache --timer. Starting Restore /run/initramfs on shutdown... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... [ OK ] Started Login Service. [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg232-client login: [ 119.869804] libcfs: loading out-of-tree module taints kernel. [ 120.194112] Key type ._llcrypt registered [ 120.196019] Key type .llcrypt registered [ 120.735308] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 120.765745] alg: No test for adler32 (adler32-zlib) [ 122.299099] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 123.266376] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 125.096689] Key type lgssc registered [ 127.105936] Lustre: Echo OBD driver; http://www.lustre.org/ [ 292.956517] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 299.099910] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 311.937167] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing check_logdir /tmp/testlogs/ [ 318.431325] Lustre: lustre-OST0000-osc-ffff99dec42fb000: disconnect after 23s idle [ 318.905835] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing yml_node [ 324.837221] Lustre: DEBUG MARKER: Client: 2.17.58.39 [ 327.444952] Lustre: DEBUG MARKER: MDS: 2.17.58.39 [ 330.029402] Lustre: DEBUG MARKER: OSS: 2.17.58.39 [ 331.821954] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Sep 17 04:55:03 EDT 2026 [ 350.316261] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 351.799199] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 354.286992] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 364.710217] Lustre: Unmounted lustre-client [ 530.914798] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 540.168929] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 570.202445] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 615.320961] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 04:59:46 (1789635586) [ 618.722436] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 621.564294] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 04:59:52 (1789635592) [ 661.270102] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 667.790276] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 690.948791] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 702.020782] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 707.139476] Lustre: Unmounted lustre-client [ 736.110647] Key type lgssc unregistered [ 736.537558] LNet: 15063:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 736.553711] LNetError: 15063:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 736.581026] LNet: Removed LNI 192.168.202.32@tcp [ 737.722345] Key type .llcrypt unregistered [ 737.725800] Key type ._llcrypt unregistered [ 752.892784] Key type ._llcrypt registered [ 752.894557] Key type .llcrypt registered [ 754.241866] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 05:02:05 (1789635725) [ 755.876160] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 755.892644] alg: No test for adler32 (adler32-zlib) [ 756.863491] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 757.054391] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 758.687521] Key type lgssc registered [ 759.795418] Lustre: Echo OBD driver; http://www.lustre.org/ [ 832.555332] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 917.750226] Lustre: Unmounted lustre-client [ 953.506693] Key type lgssc unregistered [ 953.762813] LNet: 18841:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 953.779219] LNetError: 18841:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 954.857687] LNet: Removed LNI 192.168.202.32@tcp [ 955.663381] Key type .llcrypt unregistered [ 955.665607] Key type ._llcrypt unregistered [ 966.258878] Key type ._llcrypt registered [ 966.260424] Key type .llcrypt registered [ 967.701103] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 05:05:39 (1789635939) [ 970.061388] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 970.092140] alg: No test for adler32 (adler32-zlib) [ 971.196693] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 971.398141] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 973.071221] Key type lgssc registered [ 974.068800] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1018.192960] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1023.221830] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1043.450122] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1046.066851] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 1055.133945] Lustre: Unmounted lustre-client [ 1089.964301] Key type lgssc unregistered [ 1090.242993] LNet: 22431:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1090.259984] LNetError: 22431:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1090.293570] LNet: Removed LNI 192.168.202.32@tcp [ 1090.860868] Key type .llcrypt unregistered [ 1090.863716] Key type ._llcrypt unregistered [ 1100.900501] Key type ._llcrypt registered [ 1100.903130] Key type .llcrypt registered [ 1102.233446] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 05:07:53 (1789636073) [ 1104.380667] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1104.450151] alg: No test for adler32 (adler32-zlib) [ 1105.521062] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 1105.761759] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 1107.431750] Key type lgssc registered [ 1108.651815] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1152.870788] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1157.572510] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1173.767711] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1179.677748] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 1184.800458] Lustre: Unmounted lustre-client [ 1209.501565] Key type lgssc unregistered [ 1209.702511] LNet: 25618:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1209.709237] LNetError: 25618:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1209.723123] LNet: Removed LNI 192.168.202.32@tcp [ 1210.287199] Key type .llcrypt unregistered [ 1210.290238] Key type ._llcrypt unregistered [ 1221.692519] Key type ._llcrypt registered [ 1221.701572] Key type .llcrypt registered [ 1222.713618] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 05:09:54 (1789636194) [ 1224.909723] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1224.939255] alg: No test for adler32 (adler32-zlib) [ 1225.931963] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 1226.191027] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 1227.847369] Key type lgssc registered [ 1228.933309] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1266.844747] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1270.475578] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1286.494756] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1297.426481] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 1302.512677] Lustre: lustre-MDT0000-mdc-ffff99dec5074800: Connection to lustre-MDT0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1312.743108] Lustre: lustre-MDT0001-mdc-ffff99dec5074800: Connection to lustre-MDT0001 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1318.413272] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1323.999671] Lustre: 26572:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789636280/real 1789636280] req@000000005703df08 x1876569567008768/t0(0) o400->MGC192.168.202.132@tcp@192.168.202.132@tcp:26/25 lens 224/224 e 0 to 1 dl 1789636296 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1324.027091] LustreError: MGC192.168.202.132@tcp: Connection to MGS (at 192.168.202.132@tcp) was lost; in progress operations using this service will fail [ 1328.760928] Lustre: Unmounted lustre-client [ 1353.084512] Key type lgssc unregistered [ 1353.303994] LNet: 29263:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1353.312310] LNetError: 29263:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1353.327936] LNet: Removed LNI 192.168.202.32@tcp [ 1353.891403] Key type .llcrypt unregistered [ 1353.893772] Key type ._llcrypt unregistered [ 1364.871351] Key type ._llcrypt registered [ 1364.872904] Key type .llcrypt registered [ 1365.844324] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 05:12:17 (1789636337) [ 1367.372866] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1367.441919] alg: No test for adler32 (adler32-zlib) [ 1368.534083] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 1368.777290] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 1370.431700] Key type lgssc registered [ 1371.304398] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1408.697446] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1412.974724] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1428.803599] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1439.815768] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 1444.838341] Lustre: lustre-OST0000-osc-ffff99decc372800: Connection to lustre-OST0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1451.372630] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1461.730903] Lustre: Unmounted lustre-client [ 1494.408208] Key type lgssc unregistered [ 1494.622036] LNet: 32868:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1494.633441] LNetError: 32868:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1494.651042] LNet: Removed LNI 192.168.202.32@tcp [ 1495.213068] Key type .llcrypt unregistered [ 1495.215143] Key type ._llcrypt unregistered [ 1505.955492] Key type ._llcrypt registered [ 1505.957575] Key type .llcrypt registered [ 1506.928600] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 05:14:38 (1789636478) [ 1508.474590] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1508.555110] alg: No test for adler32 (adler32-zlib) [ 1509.548412] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 1509.752421] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 1511.367390] Key type lgssc registered [ 1512.350452] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1550.214901] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1554.754789] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1572.795584] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1579.079976] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 1581.984815] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1584.690420] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1596.072350] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-17 5h16m07s [ 1597.499753] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1599.478223] Lustre: lustre-MDT0000-mdc-ffff99dec5e6f800: Connection to lustre-MDT0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1607.018220] LustreError: 36651:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff99dec5e6f800: can't stat MDS #0: rc = -19 [ 1608.280427] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1616.872606] LustreError: MGC192.168.202.132@tcp: Connection to MGS (at 192.168.202.132@tcp) was lost; in progress operations using this service will fail [ 1616.884993] Lustre: Evicted from MGS (at 192.168.202.132@tcp) after server handle changed from 0x98b754f177607903 to 0x98b754f177607ca6 [ 1616.896129] Lustre: MGC192.168.202.132@tcp: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [ 1617.964674] LustreError: lustre-MDT0000-mdc-ffff99dec5e6f800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1617.990432] Lustre: lustre-MDT0000-mdc-ffff99dec5e6f800: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [ 1620.829186] Lustre: DEBUG MARKER: Wait for df (36651) ... [ 1622.187940] Lustre: DEBUG MARKER: done [ 1623.604241] Lustre: Unmounted lustre-client [ 1656.196810] Key type lgssc unregistered [ 1656.437516] LNet: 37663:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1656.449331] LNetError: 37663:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1656.463830] LNet: Removed LNI 192.168.202.32@tcp [ 1657.130116] Key type .llcrypt unregistered [ 1657.135179] Key type ._llcrypt unregistered [ 1683.025611] Key type ._llcrypt registered [ 1683.028189] Key type .llcrypt registered [ 1683.855701] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 05:17:35 (1789636655) [ 1685.890267] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1685.900723] alg: No test for adler32 (adler32-zlib) [ 1686.868906] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 1687.050111] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 1688.695263] Key type lgssc registered [ 1689.553440] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1731.659556] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1736.406783] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1753.871063] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1755.392124] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 1759.138333] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-17 5h18m51s [ 1760.400157] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1765.986436] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1767.909654] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1788.383263] Lustre: 41806:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789636741/real 1789636741] req@000000002030b941 x1876570050402432/t0(0) o101->lustre-MDT0000-mdc-ffff99decc4b1800@192.168.202.132@tcp:12/10 lens 576/1152 e 0 to 1 dl 1789636761 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1788.410782] Lustre: lustre-MDT0000-mdc-ffff99decc4b1800: Connection to lustre-MDT0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1788.446785] Lustre: lustre-MDT0000-mdc-ffff99decc4b1800: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [ 1809.134978] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1811.099245] Lustre: DEBUG MARKER: done [ 1813.923355] Lustre: Unmounted lustre-client [ 1838.554447] Key type lgssc unregistered [ 1838.756437] LNet: 42679:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1838.763790] LNetError: 42679:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1838.784028] LNet: Removed LNI 192.168.202.32@tcp [ 1839.304622] Key type .llcrypt unregistered [ 1839.306219] Key type ._llcrypt unregistered [ 1863.209517] Key type ._llcrypt registered [ 1863.211394] Key type .llcrypt registered [ 1864.203767] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 05:20:36 (1789636836) [ 1865.387653] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1866.803670] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 05:20:38 (1789636838) [ 1869.641880] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1869.654259] alg: No test for adler32 (adler32-zlib) [ 1870.585416] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 1870.750867] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 1872.399573] Key type lgssc registered [ 1873.159272] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1894.364780] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 05:21:06 (1789636866) [ 1919.217629] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1924.527974] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1941.615521] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1944.152255] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 1946.838770] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1949.225737] Lustre: Unmounted lustre-client [ 1959.370468] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2003.168400] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2007.810895] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2008.381423] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 2011.165510] Lustre: Unmounted lustre-client [ 2067.693615] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2072.150105] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2072.590726] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 2075.075584] Lustre: Unmounted lustre-client [ 2093.115545] Lustre: DEBUG MARKER: files compared the same [ 2112.889522] Key type lgssc unregistered [ 2113.120475] LNet: 50289:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2113.135482] LNetError: 50289:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2113.154454] LNet: Removed LNI 192.168.202.32@tcp [ 2113.769770] Key type .llcrypt unregistered [ 2113.771759] Key type ._llcrypt unregistered [ 2124.813551] Key type ._llcrypt registered [ 2124.815842] Key type .llcrypt registered [ 2125.700306] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 05:24:57 (1789637097) [ 2127.479120] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2127.516715] alg: No test for adler32 (adler32-zlib) [ 2128.436810] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 2128.676967] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 2130.343360] Key type lgssc registered [ 2131.419410] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2165.877756] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2169.834964] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2183.919454] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2186.333892] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 2189.502428] Lustre: Unmounted lustre-client [ 2221.344454] Key type lgssc unregistered [ 2221.555684] LNet: 53859:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2221.559596] LNetError: 53859:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2221.569731] LNet: Removed LNI 192.168.202.32@tcp [ 2222.108829] Key type .llcrypt unregistered [ 2222.110601] Key type ._llcrypt unregistered [ 2232.635917] Key type ._llcrypt registered [ 2232.637591] Key type .llcrypt registered [ 2233.744549] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 05:26:45 (1789637205) [ 2235.429190] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2235.487438] alg: No test for adler32 (adler32-zlib) [ 2236.462079] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 2236.630268] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 2238.287361] Key type lgssc registered [ 2239.128242] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2312.881448] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2336.689458] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2340.853454] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2375.021607] Key type lgssc unregistered [ 2375.335693] LNet: 57338:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2375.339794] LNetError: 57338:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2375.362921] LNet: Removed LNI 192.168.202.32@tcp [ 2376.013161] Key type .llcrypt unregistered [ 2376.015841] Key type ._llcrypt unregistered [ 2388.141406] Key type ._llcrypt registered [ 2388.143336] Key type .llcrypt registered [ 2389.087648] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 05:29:21 (1789637361) [ 2391.263139] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2391.292364] alg: No test for adler32 (adler32-zlib) [ 2392.298064] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 2392.489397] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 2394.127952] Key type lgssc registered [ 2395.084613] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2459.681816] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 2466.076602] Lustre: Unmounted lustre-client [ 2496.825110] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 05:31:08 (1789637468) [ 2583.048448] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2597.426721] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 2603.678504] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2603.683511] LustreError: 63803:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff99dec69f8000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2603.715736] Lustre: 58321:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.132@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2614.020582] Lustre: Unmounted lustre-client [ 2655.097747] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 05:33:47 (1789637627) [ 2661.092837] Key type lgssc unregistered [ 2661.290383] LNet: 65013:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2661.294902] LNetError: 65013:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2661.309458] LNet: Removed LNI 192.168.202.32@tcp [ 2661.789095] Key type .llcrypt unregistered [ 2661.790670] Key type ._llcrypt unregistered [ 2669.952476] Key type ._llcrypt registered [ 2669.954129] Key type .llcrypt registered [ 2670.126711] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2670.135962] alg: No test for adler32 (adler32-zlib) [ 2671.041341] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 2671.197266] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 2672.791250] Key type lgssc registered [ 2673.364383] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2717.068356] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2722.510218] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2748.823269] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2750.617783] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 2755.715367] Lustre: Unmounted lustre-client [ 2789.942423] Key type lgssc unregistered [ 2790.436343] LNet: 68022:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2790.445668] LNetError: 68022:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2790.477310] LNet: Removed LNI 192.168.202.32@tcp [ 2791.876798] Key type .llcrypt unregistered [ 2791.878380] Key type ._llcrypt unregistered [ 2806.256121] Key type ._llcrypt registered [ 2806.260783] Key type .llcrypt registered [ 2806.911726] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2806.927373] alg: No test for adler32 (adler32-zlib) [ 2808.089779] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 2808.311620] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 2810.031237] Key type lgssc registered [ 2811.309841] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2923.072564] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2928.362476] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2949.542397] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2951.150431] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 2959.065795] Lustre: Unmounted lustre-client [ 2987.905771] Key type lgssc unregistered [ 2988.227223] LNet: 71450:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2988.242129] LNetError: 71450:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2988.261922] LNet: Removed LNI 192.168.202.32@tcp [ 2988.979185] Key type .llcrypt unregistered [ 2988.981137] Key type ._llcrypt unregistered [ 3006.812968] Key type ._llcrypt registered [ 3006.815262] Key type .llcrypt registered [ 3008.490501] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 05:39:39 (1789637979) [ 3010.999992] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3011.066277] alg: No test for adler32 (adler32-zlib) [ 3012.167551] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 3012.418872] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 3014.200127] Key type lgssc registered [ 3015.736943] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3073.833640] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3079.658471] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3102.030461] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3104.814660] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 3113.738025] Lustre: Unmounted lustre-client [ 3114.197705] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 3118.267251] Lustre: Unmounted lustre-client [ 3165.482457] Key type lgssc unregistered [ 3165.748060] LNet: 75134:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3165.753616] LNetError: 75134:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3165.778020] LNet: Removed LNI 192.168.202.32@tcp [ 3166.703756] Key type .llcrypt unregistered [ 3166.712319] Key type ._llcrypt unregistered [ 3179.155763] Key type ._llcrypt registered [ 3179.157313] Key type .llcrypt registered [ 3179.533290] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3179.553156] alg: No test for adler32 (adler32-zlib) [ 3180.637939] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 3180.823606] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 3182.479284] Key type lgssc registered [ 3183.714268] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3248.472831] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3257.378766] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3281.841744] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3287.598572] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 3293.865748] Lustre: Unmounted lustre-client [ 3324.298950] Key type lgssc unregistered [ 3324.787777] LNet: 78165:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3324.809370] LNetError: 78165:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3324.838092] LNet: Removed LNI 192.168.202.32@tcp [ 3325.748887] Key type .llcrypt unregistered [ 3325.752220] Key type ._llcrypt unregistered [ 3346.648996] Key type ._llcrypt registered [ 3346.652253] Key type .llcrypt registered [ 3348.099290] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 05:45:19 (1789638319) [ 3351.640893] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3351.662312] alg: No test for adler32 (adler32-zlib) [ 3352.787339] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 3353.049545] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 3354.768440] Key type lgssc registered [ 3356.369444] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3411.696469] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3418.064560] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3439.810851] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3442.615261] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 3455.506851] Lustre: lustre: root_squash is set to 0:0 [ 3455.528359] Lustre: lustre: nosquash_nids is cleared [ 3465.809250] Lustre: lustre: root_squash is set to 500:500 [ 3481.115820] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.32@tcp 192.168.0.[2,10]@tcp [ 3487.930886] Lustre: lustre: nosquash_nids set to 192.168.202.32/24@tcp [ 3491.772199] Lustre: Unmounted lustre-client [ 3532.455825] Key type lgssc unregistered [ 3532.641649] LNet: 82131:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3532.650249] LNetError: 82131:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3532.675712] LNet: Removed LNI 192.168.202.32@tcp [ 3533.555615] Key type .llcrypt unregistered [ 3533.566581] Key type ._llcrypt unregistered [ 3551.368761] Key type ._llcrypt registered [ 3551.370514] Key type .llcrypt registered [ 3552.880321] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 05:48:44 (1789638524) [ 3555.805470] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3558.103878] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 05:48:49 (1789638529) [ 3562.045152] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3562.082259] alg: No test for adler32 (adler32-zlib) [ 3563.837126] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 3564.450506] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 3566.252881] Key type lgssc registered [ 3568.282400] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3623.195102] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3628.405128] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3650.502896] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3652.451393] Lustre: lustre: root_squash is set to 500:500 [ 3652.476813] Lustre: lustre: nosquash_nids set to 192.168.202.32/24@tcp [ 3653.594540] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 3660.423306] Lustre: Unmounted lustre-client [ 3690.071685] Key type lgssc unregistered [ 3690.461703] LNet: 86089:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3690.478224] LNetError: 86089:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3690.509737] LNet: Removed LNI 192.168.202.32@tcp [ 3691.288965] Key type .llcrypt unregistered [ 3691.290678] Key type ._llcrypt unregistered [ 3708.622785] Key type ._llcrypt registered [ 3708.625443] Key type .llcrypt registered [ 3709.956509] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3711.825592] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 05:51:23 (1789638683) [ 3730.593371] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3730.908627] alg: No test for adler32 (adler32-zlib) [ 3731.930160] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 3732.095580] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 3733.839255] Key type lgssc registered [ 3735.232530] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3820.196327] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3826.206939] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3850.367596] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3918.879784] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3924.051438] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3944.548853] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3956.550160] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 3991.756914] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff99dec2a82000.ost_server_uuid 50 [ 3993.773819] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff99dec2a82000.ost_server_uuid in IDLE state after 0 sec [ 3994.257154] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 3998.680968] Lustre: Unmounted lustre-client [ 4000.680565] Lustre: Unmounted lustre-client [ 4052.958625] Key type lgssc unregistered [ 4053.407222] LNet: 93745:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4053.416587] LNetError: 93745:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4053.449759] LNet: Removed LNI 192.168.202.32@tcp [ 4054.754131] Key type .llcrypt unregistered [ 4054.756767] Key type ._llcrypt unregistered [ 4089.673479] Key type ._llcrypt registered [ 4089.675546] Key type .llcrypt registered [ 4090.878596] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 05:57:42 (1789639062) [ 4107.091851] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4107.120858] alg: No test for adler32 (adler32-zlib) [ 4108.185148] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 4108.486693] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 4110.215267] Key type lgssc registered [ 4111.233668] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4175.075991] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4179.381806] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4197.402914] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4199.917759] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 4220.408544] Lustre: lustre-OST0000-osc-ffff99dec3f1d800: Connection to lustre-OST0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4221.407168] Lustre: 95104:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789639178/real 1789639178] req@00000000fa3e501c x1876572589004032/t0(0) o400->lustre-OST0000-osc-ffff99dec3f1d800@192.168.202.132@tcp:28/4 lens 224/224 e 0 to 1 dl 1789639194 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4224.618775] Lustre: lustre-OST0000-osc-ffff99dec3f1d800: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [ 4226.527324] Lustre: 95104:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789639183/real 1789639183] req@000000005ea47ec9 x1876572589004544/t0(0) o400->lustre-OST0000-osc-ffff99dec3f1d800@192.168.202.132@tcp:28/4 lens 224/224 e 0 to 1 dl 1789639199 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4230.628383] Lustre: lustre-MDT0000-mdc-ffff99dec3f1d800: Connection to lustre-MDT0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4231.647642] Lustre: 95103:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789639188/real 1789639188] req@000000009b76de92 x1876572589005056/t0(0) o400->lustre-OST0000-osc-ffff99dec3f1d800@192.168.202.132@tcp:28/4 lens 224/224 e 0 to 1 dl 1789639204 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4245.990779] LustreError: MGC192.168.202.132@tcp: Connection to MGS (at 192.168.202.132@tcp) was lost; in progress operations using this service will fail [ 4246.016146] Lustre: Evicted from MGS (at 192.168.202.132@tcp) after server handle changed from 0x7fd6f03fa7c0944 to 0x7fd6f03fa7c0bd6 [ 4246.029479] Lustre: MGC192.168.202.132@tcp: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [ 4250.188533] Lustre: lustre-MDT0000-mdc-ffff99dec3f1d800: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [ 4251.939154] Lustre: Unmounted lustre-client [ 4274.154388] Key type lgssc unregistered [ 4274.352427] LNet: 99394:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4274.357891] LNetError: 99394:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4274.379090] LNet: Removed LNI 192.168.202.32@tcp [ 4274.867495] Key type .llcrypt unregistered [ 4274.872083] Key type ._llcrypt unregistered [ 4285.235457] Key type ._llcrypt registered [ 4285.236813] Key type .llcrypt registered [ 4286.207974] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 06:00:58 (1789639258) [ 4299.881895] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4299.906019] alg: No test for adler32 (adler32-zlib) [ 4300.885725] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 4301.036921] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 4302.663671] Key type lgssc registered [ 4303.577780] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4344.616665] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4460.836061] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4465.778783] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4488.846192] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4490.425446] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 4492.569269] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4494.114835] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 06:04:25 (1789639465) [ 4709.814870] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4720.150994] Lustre: Unmounted lustre-client [ 4851.842887] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4858.083745] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4885.842498] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4928.633701] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 06:11:40 (1789639900) [ 5032.042529] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5038.342543] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5065.492636] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5066.425878] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 5071.312358] Lustre: Unmounted lustre-client [ 5110.249487] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 06:14:41 (1789640081) [ 5200.598548] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5206.495843] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5227.354762] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5227.905191] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 5231.076683] Lustre: Unmounted lustre-client [ 5251.818175] Key type lgssc unregistered [ 5252.016777] LNet: 122437:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5252.021512] LNetError: 122437:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5252.035115] LNet: Removed LNI 192.168.202.32@tcp [ 5252.624732] Key type .llcrypt unregistered [ 5252.628416] Key type ._llcrypt unregistered [ 5265.866876] Key type ._llcrypt registered [ 5265.872760] Key type .llcrypt registered [ 5267.074866] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 06:17:18 (1789640238) [ 5269.044645] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5269.105559] alg: No test for adler32 (adler32-zlib) [ 5270.111360] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 5270.288996] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 5271.951376] Key type lgssc registered [ 5272.915374] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5315.825654] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5320.939668] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5344.869107] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5346.595771] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 5359.811293] Lustre: Unmounted lustre-client [ 5387.402545] Key type lgssc unregistered [ 5387.724689] LNet: 126040:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5387.731377] LNetError: 126040:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5387.746568] LNet: Removed LNI 192.168.202.32@tcp [ 5388.453571] Key type .llcrypt unregistered [ 5388.455681] Key type ._llcrypt unregistered [ 5405.256075] Key type ._llcrypt registered [ 5405.259532] Key type .llcrypt registered [ 5406.509279] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 06:19:38 (1789640378) [ 5409.276298] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5409.479329] alg: No test for adler32 (adler32-zlib) [ 5410.603693] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 5410.922782] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 5412.623270] Key type lgssc registered [ 5413.794559] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5460.184591] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5466.838629] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5493.143139] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5496.101924] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 5501.417173] Lustre: lustre-OST0000-osc-ffff99dec5b18800: Connection to lustre-OST0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5513.347370] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff99dec5b18800.ost_server_uuid 50 [ 5515.719498] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5526.676324] Lustre: Unmounted lustre-client [ 5548.649621] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 06:22:00 (1789640520) [ 5583.062889] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5589.324297] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5613.045816] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5643.701889] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5644.491441] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 5649.916165] Lustre: lustre-OST0000-osc-ffff99decace1800: Connection to lustre-OST0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5678.742669] Lustre: Unmounted lustre-client [ 5729.391244] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 06:25:00 (1789640700) [ 5769.152649] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5775.278360] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5796.069582] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5820.830539] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5821.517702] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 5826.537779] Lustre: lustre-OST0000-osc-ffff99dec58c8800: Connection to lustre-OST0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5842.530494] Lustre: Unmounted lustre-client [ 5887.898935] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 06:27:39 (1789640859) [ 5984.702747] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5989.966283] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6013.862934] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6086.616464] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6092.187570] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6115.214770] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6146.261852] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 6189.515592] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6193.427211] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 2 sec [ 6195.411370] Lustre: Unmounted lustre-client [ 6230.121063] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 06:33:21 (1789641201) [ 6265.061448] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6271.950169] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6298.305409] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6332.594331] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6362.461201] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 6405.058222] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6406.642418] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6408.678399] Lustre: lustre-OST0001-osc-ffff99decc4b7000: Connection to lustre-OST0001 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6420.035307] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6430.450209] Lustre: Unmounted lustre-client [ 6485.529965] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 06:37:37 (1789641457) [ 6519.495178] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6525.421604] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6544.171966] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6544.837924] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 6573.415273] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6575.521749] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6595.894577] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff99dec58ce800.ost_server_uuid 50 [ 6598.192593] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff99dec58ce800.ost_server_uuid in IDLE state after 0 sec [ 6601.502299] Lustre: Unmounted lustre-client [ 6601.963796] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6601.968836] Lustre: Skipped 3 previous similar messages [ 6602.056966] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 6603.299960] LustreError: 149476:0:(sec.c:409:import_sec_validate_get()) import 00000000d24afaa2 (NEW) with no sec [ 6667.629485] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 06:40:39 (1789641639) [ 6705.007553] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6711.709142] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6738.871538] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6769.295156] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6770.264826] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6770.481227] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 6782.682378] Lustre: Unmounted lustre-client [ 6782.694039] Lustre: Skipped 1 previous similar message [ 6828.184956] Key type lgssc unregistered [ 6828.637637] LNet: 152883:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6828.659912] LNetError: 152883:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6828.708277] LNet: Removed LNI 192.168.202.32@tcp [ 6829.828894] Key type .llcrypt unregistered [ 6829.833261] Key type ._llcrypt unregistered [ 6852.029276] Key type ._llcrypt registered [ 6852.031965] Key type .llcrypt registered [ 6853.664358] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 06:43:44 (1789641824) [ 6855.104497] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6855.120751] alg: No test for adler32 (adler32-zlib) [ 6856.337241] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 6856.677434] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 6858.375364] Key type lgssc registered [ 6860.563056] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6920.091866] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6927.197336] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6956.009503] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6979.403235] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6979.873490] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6981.029709] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 6985.337505] LustreError: lustre-MDT0001-mdc-ffff99decc372800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6985.359123] Lustre: lustre-MDT0001-mdc-ffff99decc372800: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [ 6992.673551] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6994.764652] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7016.483110] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7021.260581] Lustre: Unmounted lustre-client [ 7045.699641] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 06:46:57 (1789642017) [ 7145.697587] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7151.405394] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7176.771871] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7177.375598] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 7209.767531] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7212.262825] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7225.202777] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7235.612750] Lustre: Unmounted lustre-client [ 7289.266718] Key type lgssc unregistered [ 7289.537876] LNet: 162471:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7289.553033] LNetError: 162471:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7290.603840] LNet: Removed LNI 192.168.202.32@tcp [ 7291.343863] Key type .llcrypt unregistered [ 7291.346037] Key type ._llcrypt unregistered [ 7325.615504] Key type ._llcrypt registered [ 7325.617708] Key type .llcrypt registered [ 7326.942363] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 06:51:38 (1789642298) [ 7330.230698] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7330.251132] alg: No test for adler32 (adler32-zlib) [ 7331.523574] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 7331.840411] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 7333.527650] Key type lgssc registered [ 7334.822254] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7389.604601] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7395.433921] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7415.902583] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7418.506498] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 7463.166901] Lustre: Unmounted lustre-client [ 7507.790210] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7508.575823] LustreError: 163612:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 7508.604645] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 7544.907925] Lustre: Unmounted lustre-client [ 7575.464724] Key type lgssc unregistered [ 7575.762653] LNet: 166915:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7575.769298] LNetError: 166915:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7575.790272] LNet: Removed LNI 192.168.202.32@tcp [ 7576.485204] Key type .llcrypt unregistered [ 7576.486900] Key type ._llcrypt unregistered [ 7593.101100] Key type ._llcrypt registered [ 7593.102753] Key type .llcrypt registered [ 7594.621876] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 06:56:05 (1789642565) [ 7596.566433] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7596.652524] alg: No test for adler32 (adler32-zlib) [ 7597.679976] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 7597.902936] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 7599.599230] Key type lgssc registered [ 7601.100930] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7644.910547] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7650.363851] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7672.948666] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7675.826644] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 7693.202409] Lustre: Unmounted lustre-client [ 7719.759228] Key type lgssc unregistered [ 7720.012144] LNet: 170663:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7720.021508] LNetError: 170663:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7720.042904] LNet: Removed LNI 192.168.202.32@tcp [ 7720.725476] Key type .llcrypt unregistered [ 7720.729114] Key type ._llcrypt unregistered [ 7732.994678] Key type ._llcrypt registered [ 7732.996571] Key type .llcrypt registered [ 7733.485723] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7733.498491] alg: No test for adler32 (adler32-zlib) [ 7734.585786] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 7734.926150] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 7736.671951] Key type lgssc registered [ 7738.508149] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7793.212634] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7799.335049] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7818.941784] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7820.753170] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 7833.370135] Lustre: Unmounted lustre-client [ 7863.644535] Key type lgssc unregistered [ 7863.946191] LNet: 173722:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7863.954661] LNetError: 173722:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7865.000722] LNet: Removed LNI 192.168.202.32@tcp [ 7866.082886] Key type .llcrypt unregistered [ 7866.094840] Key type ._llcrypt unregistered [ 7884.589726] Key type ._llcrypt registered [ 7884.592685] Key type .llcrypt registered [ 7886.257559] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 07:00:57 (1789642857) [ 7888.304425] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7888.399086] alg: No test for adler32 (adler32-zlib) [ 7889.466786] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 7889.675145] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 7891.327797] Key type lgssc registered [ 7892.515936] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7947.894525] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7954.163882] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7975.109668] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7977.968597] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 8001.153935] Lustre: Unmounted lustre-client [ 8030.025949] Key type lgssc unregistered [ 8030.399292] LNet: 177483:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8030.407860] LNetError: 177483:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8030.433467] LNet: Removed LNI 192.168.202.32@tcp [ 8031.377124] Key type .llcrypt unregistered [ 8031.382064] Key type ._llcrypt unregistered [ 8046.700586] Key type ._llcrypt registered [ 8046.711802] Key type .llcrypt registered [ 8047.070237] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8047.081709] alg: No test for adler32 (adler32-zlib) [ 8048.200806] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 8048.491668] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 8050.335459] Key type lgssc registered [ 8051.866700] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8105.823760] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8111.850962] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8132.049988] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8133.934577] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 8144.871598] Lustre: Unmounted lustre-client [ 8172.951768] Key type lgssc unregistered [ 8173.277715] LNet: 180542:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8173.283878] LNetError: 180542:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8173.304791] LNet: Removed LNI 192.168.202.32@tcp [ 8173.908912] Key type .llcrypt unregistered [ 8173.911245] Key type ._llcrypt unregistered [ 8190.886570] Key type ._llcrypt registered [ 8190.891484] Key type .llcrypt registered [ 8192.318425] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 07:06:03 (1789643163) [ 8215.786293] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8215.806756] alg: No test for adler32 (adler32-zlib) [ 8216.869210] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 8217.219971] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 8218.913139] Key type lgssc registered [ 8220.187380] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8309.283034] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8315.086792] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8339.838580] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8381.815148] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 07:09:13 (1789643353) [ 8417.093146] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8422.706368] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8444.409671] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8447.487528] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 8457.819165] Lustre: Unmounted lustre-client [ 8486.626375] Key type lgssc unregistered [ 8486.838494] LNet: 187633:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8486.843657] LNetError: 187633:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8486.855624] LNet: Removed LNI 192.168.202.32@tcp [ 8487.503781] Key type .llcrypt unregistered [ 8487.505913] Key type ._llcrypt unregistered [ 8503.587268] Key type ._llcrypt registered [ 8503.589317] Key type .llcrypt registered [ 8504.920199] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8506.653148] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 07:11:18 (1789643478) [ 8527.720284] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8527.772179] alg: No test for adler32 (adler32-zlib) [ 8528.999253] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 8529.323774] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 8531.098397] Key type lgssc registered [ 8532.593403] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8624.988520] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8630.533382] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8660.088207] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8686.227862] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8688.308655] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 8717.127517] Lustre: Unmounted lustre-client [ 8840.634241] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8845.913059] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8867.126587] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8919.271888] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 07:18:10 (1789643890) [ 8920.868927] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8923.616568] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 07:18:14 (1789643894) [ 9027.467299] Key type lgssc unregistered [ 9027.730452] LNet: 199073:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9027.742056] LNetError: 199073:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9027.784359] LNet: Removed LNI 192.168.202.32@tcp [ 9028.571153] Key type .llcrypt unregistered [ 9028.580146] Key type ._llcrypt unregistered [ 9047.047590] Key type ._llcrypt registered [ 9047.053634] Key type .llcrypt registered [ 9048.240562] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 07:20:19 (1789644019) [ 9088.359606] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9088.378357] alg: No test for adler32 (adler32-zlib) [ 9089.478537] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 9089.727285] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 9091.416895] Key type lgssc registered [ 9092.485309] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9146.039554] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9152.889295] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9187.266874] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9222.902588] Key type lgssc unregistered [ 9223.171933] LNet: 202804:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9223.179344] LNetError: 202804:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9223.199675] LNet: Removed LNI 192.168.202.32@tcp [ 9223.954903] Key type .llcrypt unregistered [ 9223.961229] Key type ._llcrypt unregistered [ 9242.667782] Key type ._llcrypt registered [ 9242.672209] Key type .llcrypt registered [ 9244.265768] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 07:23:35 (1789644215) [ 9247.324824] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9247.364563] alg: No test for adler32 (adler32-zlib) [ 9248.615529] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 9248.976225] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 9250.691740] Key type lgssc registered [ 9252.830519] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9304.209292] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9310.352352] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9336.276908] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9337.908937] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [ 9348.078754] Lustre: lustre-MDT0000-mdc-ffff99decc372800: Connection to lustre-MDT0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9358.330631] Lustre: lustre-MDT0001-mdc-ffff99decc372800: Connection to lustre-MDT0001 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9369.312502] Lustre: 203794:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789644326/real 1789644326] req@00000000dfd4d1af x1876577978761344/t0(0) o400->MGC192.168.202.132@tcp@192.168.202.132@tcp:26/25 lens 224/224 e 0 to 1 dl 1789644342 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9369.376619] LustreError: MGC192.168.202.132@tcp: Connection to MGS (at 192.168.202.132@tcp) was lost; in progress operations using this service will fail [ 9379.704552] Lustre: Evicted from MGS (at 192.168.202.132@tcp) after server handle changed from 0x90ca5d94c25dfcb1 to 0x90ca5d94c25e1841 [ 9379.740554] Lustre: MGC192.168.202.132@tcp: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [ 9403.366503] LustreError: lustre-MDT0000-mdc-ffff99decc372800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9403.395212] Lustre: lustre-MDT0000-mdc-ffff99decc372800: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [ 9410.456591] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9412.305534] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9418.749144] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9420.724338] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9425.106181] Lustre: Unmounted lustre-client [ 9463.095852] Key type lgssc unregistered [ 9463.449517] LNet: 207752:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9463.463204] LNetError: 207752:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9463.480943] LNet: Removed LNI 192.168.202.32@tcp [ 9464.264151] Key type .llcrypt unregistered [ 9464.266114] Key type ._llcrypt unregistered [ 9483.395241] Key type ._llcrypt registered [ 9483.396526] Key type .llcrypt registered [ 9485.160332] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 07:27:36 (1789644456) [ 9487.260373] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9487.444265] alg: No test for adler32 (adler32-zlib) [ 9488.607592] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 9488.790780] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 9490.473229] Key type lgssc registered [ 9492.080923] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9542.576165] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9547.750871] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9605.333170] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9611.444619] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9648.095905] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9675.312759] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9723.661880] Key type lgssc unregistered [ 9723.873061] LNet: 213048:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9723.877828] LNetError: 213048:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9723.893565] LNet: Removed LNI 192.168.202.32@tcp [ 9724.599493] Key type .llcrypt unregistered [ 9724.606313] Key type ._llcrypt unregistered [ 9767.754719] Key type ._llcrypt registered [ 9767.757773] Key type .llcrypt registered [ 9769.191750] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 07:32:20 (1789644740) [ 9817.685546] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9817.801520] alg: No test for adler32 (adler32-zlib) [ 9818.922699] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [ 9819.166463] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [ 9820.888346] Key type lgssc registered [ 9822.381881] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9909.094817] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9914.673417] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9939.591539] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9985.571687] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 07:35:57 (1789644957) [ 9995.740750] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 07:36:06 (1789644966) [10031.938190] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10039.121982] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10061.866228] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10063.894569] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [10069.515674] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10071.590460] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10073.153903] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10074.941179] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10079.213168] Lustre: lustre-MDT0000-mdc-ffff99decace3800: Connection to lustre-MDT0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [10095.586208] Lustre: 214941:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789645052/real 1789645052] req@000000007c7e3ce1 x1876578577425920/t0(0) o400->MGC192.168.202.132@tcp@192.168.202.132@tcp:26/25 lens 224/224 e 0 to 1 dl 1789645068 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10095.618228] LustreError: MGC192.168.202.132@tcp: Connection to MGS (at 192.168.202.132@tcp) was lost; in progress operations using this service will fail [10105.840798] Lustre: Evicted from MGS (at 192.168.202.132@tcp) after server handle changed from 0x8bb4f84ca57de0f to 0x8bb4f84ca57e085 [10105.871316] Lustre: MGC192.168.202.132@tcp: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [10109.569831] Lustre: lustre-MDT0000-mdc-ffff99decace3800: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [10121.237838] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10123.266141] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10126.982843] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10131.446722] Lustre: lustre-MDT0000-mdc-ffff99decace3800: Connection to lustre-MDT0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [10147.807153] Lustre: 214944:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789645104/real 1789645104] req@0000000098b81ef7 x1876578577435264/t0(0) o400->MGC192.168.202.132@tcp@192.168.202.132@tcp:26/25 lens 224/224 e 0 to 1 dl 1789645120 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10147.846254] LustreError: MGC192.168.202.132@tcp: Connection to MGS (at 192.168.202.132@tcp) was lost; in progress operations using this service will fail [10157.046892] Lustre: Evicted from MGS (at 192.168.202.132@tcp) after server handle changed from 0x8bb4f84ca57e085 to 0x8bb4f84ca57e348 [10157.080609] Lustre: MGC192.168.202.132@tcp: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [10162.858733] Lustre: lustre-MDT0000-mdc-ffff99decace3800: Connection restored to 192.168.202.132@tcp (at 192.168.202.132@tcp) [10177.721860] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10179.435997] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10183.810171] Lustre: Unmounted lustre-client [10256.860916] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10262.665959] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10285.076797] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10285.726948] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [10293.405062] Lustre: Unmounted lustre-client [10329.961466] Key type lgssc unregistered [10330.254378] LNet: 225535:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10330.269516] LNetError: 225535:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10330.284649] LNet: Removed LNI 192.168.202.32@tcp [10331.184937] Key type .llcrypt unregistered [10331.187379] Key type ._llcrypt unregistered [10348.815201] Key type ._llcrypt registered [10348.817870] Key type .llcrypt registered [10350.686358] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 07:42:01 (1789645321) [10354.805397] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10354.854966] alg: No test for adler32 (adler32-zlib) [10355.944693] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [10356.166554] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [10357.859132] Key type lgssc registered [10358.991453] Lustre: Echo OBD driver; http://www.lustre.org/ [10415.565218] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10421.324863] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10447.813044] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10449.806623] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [10458.847609] Lustre: Unmounted lustre-client [10529.626781] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10536.351260] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10557.883075] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10558.476754] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [10569.628959] Lustre: Unmounted lustre-client [10646.612135] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10652.052110] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10672.658699] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10673.357417] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [10674.399739] Lustre: Unmounted lustre-client [10702.221693] Key type lgssc unregistered [10702.601780] LNet: 232591:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10702.613525] LNetError: 232591:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10702.638982] LNet: Removed LNI 192.168.202.32@tcp [10703.274989] Key type .llcrypt unregistered [10703.277758] Key type ._llcrypt unregistered [10718.692237] Key type ._llcrypt registered [10718.693517] Key type .llcrypt registered [10719.850722] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 07:48:11 (1789645691) [10723.201275] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10723.233104] alg: No test for adler32 (adler32-zlib) [10724.466168] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [10724.663309] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [10726.311260] Key type lgssc registered [10727.986691] Lustre: Echo OBD driver; http://www.lustre.org/ [10771.230566] Key type lgssc unregistered [10771.488783] LNet: 234907:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10771.492912] LNetError: 234907:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10771.513870] LNet: Removed LNI 192.168.202.32@tcp [10772.080865] Key type .llcrypt unregistered [10772.093367] Key type ._llcrypt unregistered [10806.536900] Key type ._llcrypt registered [10806.549851] Key type .llcrypt registered [10807.342777] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10807.417841] alg: No test for adler32 (adler32-zlib) [10808.699675] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [10808.913473] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [10810.631248] Key type lgssc registered [10812.401648] Lustre: Echo OBD driver; http://www.lustre.org/ [10895.635061] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10901.568659] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10923.607770] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10964.086654] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10965.595335] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 07:52:17 (1789645937) [10995.387390] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11000.927891] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11024.156729] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11047.393612] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11049.120384] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [11054.585559] Lustre: lustre-OST0001-osc-ffff99dec8684000: Connection to lustre-OST0001 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [11063.121635] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11073.544363] Lustre: Unmounted lustre-client [11106.944539] Key type lgssc unregistered [11107.226609] LNet: 242013:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11107.234547] LNetError: 242013:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11107.249790] LNet: Removed LNI 192.168.202.32@tcp [11107.988832] Key type .llcrypt unregistered [11107.991095] Key type ._llcrypt unregistered [11138.616927] Key type ._llcrypt registered [11138.630674] Key type .llcrypt registered [11139.898878] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 07:55:11 (1789646111) [11153.109262] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11153.207117] alg: No test for adler32 (adler32-zlib) [11154.302356] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [11154.601664] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [11156.335552] Key type lgssc registered [11157.316907] Lustre: Echo OBD driver; http://www.lustre.org/ [11210.244229] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11215.860338] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11238.058343] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 07:56:49 (1789646209) [11270.243899] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11275.717929] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11295.948901] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11298.820131] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [11314.181965] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11316.564911] Lustre: Unmounted lustre-client [11433.923975] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11440.252803] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11496.015816] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11496.891132] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [11500.621227] Lustre: Unmounted lustre-client [11529.502795] Key type lgssc unregistered [11529.785402] LNet: 249706:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11529.799410] LNetError: 249706:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11529.810491] LNet: Removed LNI 192.168.202.32@tcp [11530.588198] Key type .llcrypt unregistered [11530.592544] Key type ._llcrypt unregistered [11562.264783] Key type ._llcrypt registered [11562.268563] Key type .llcrypt registered [11562.861872] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11562.889566] alg: No test for adler32 (adler32-zlib) [11563.924246] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [11564.233177] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [11565.944243] Key type lgssc registered [11567.334730] Lustre: Echo OBD driver; http://www.lustre.org/ [11644.015443] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11650.265350] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11674.119507] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11716.984511] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11718.774420] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 08:04:50 (1789646690) [11757.545469] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11763.420938] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11783.997963] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11788.434302] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [11796.247571] Lustre: Unmounted lustre-client [11823.714114] Key type lgssc unregistered [11824.025603] LNet: 256339:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11824.029210] LNetError: 256339:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11824.060096] LNet: Removed LNI 192.168.202.32@tcp [11824.773637] Key type .llcrypt unregistered [11824.775813] Key type ._llcrypt unregistered [11843.801086] Key type ._llcrypt registered [11843.803877] Key type .llcrypt registered [11845.517915] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11847.101518] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 08:06:58 (1789646818) [11857.794628] Key type .llcrypt unregistered [11857.800086] Key type ._llcrypt unregistered [11867.236308] Key type ._llcrypt registered [11867.240721] Key type .llcrypt registered [11867.851135] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11867.912661] alg: No test for adler32 (adler32-zlib) [11869.126112] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [11869.423311] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [11871.199697] Key type lgssc registered [11872.532232] Lustre: Echo OBD driver; http://www.lustre.org/ [11929.120308] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11947.001750] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [11950.060288] Lustre: Unmounted lustre-client [11977.116894] Key type lgssc unregistered [11977.365591] LNet: 259792:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11977.371985] LNetError: 259792:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11977.392943] LNet: Removed LNI 192.168.202.32@tcp [11978.197863] Key type .llcrypt unregistered [11978.203613] Key type ._llcrypt unregistered [11991.317589] Key type ._llcrypt registered [11991.319718] Key type .llcrypt registered [11992.423608] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 08:09:24 (1789646964) [11994.763445] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11994.786464] alg: No test for adler32 (adler32-zlib) [11995.827443] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [11996.069914] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [11997.727314] Key type lgssc registered [11999.687687] Lustre: Echo OBD driver; http://www.lustre.org/ [12086.834947] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12122.216511] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12129.099582] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12131.956189] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [12135.496415] Lustre: Unmounted lustre-client [12164.709177] Key type lgssc unregistered [12164.938626] LNet: 263334:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12164.950890] LNetError: 263334:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12164.967619] LNet: Removed LNI 192.168.202.32@tcp [12166.095618] Key type .llcrypt unregistered [12166.099827] Key type ._llcrypt unregistered [12184.777840] Key type ._llcrypt registered [12184.780165] Key type .llcrypt registered [12186.335560] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 08:12:37 (1789647157) [12189.074080] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12189.109923] alg: No test for adler32 (adler32-zlib) [12190.287753] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [12190.571551] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [12192.279357] Key type lgssc registered [12193.614737] Lustre: Echo OBD driver; http://www.lustre.org/ [12248.296156] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12255.390200] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12281.177951] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12292.163134] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [12297.197406] Lustre: lustre-MDT0000-mdc-ffff99dec483f000: Connection to lustre-MDT0000 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [12303.539970] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12303.559953] LustreError: 266492:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12304.057089] LustreError: MGC192.168.202.132@tcp: Connection to MGS (at 192.168.202.132@tcp) was lost; in progress operations using this service will fail [12304.141371] Lustre: Unmounted lustre-client [12323.601527] Key type lgssc unregistered [12323.906826] LNet: 266905:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12323.914772] LNetError: 266905:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12323.937904] LNet: Removed LNI 192.168.202.32@tcp [12324.647150] Key type .llcrypt unregistered [12324.648543] Key type ._llcrypt unregistered [12341.642213] Key type ._llcrypt registered [12341.645560] Key type .llcrypt registered [12343.273310] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 08:15:14 (1789647314) [12345.428093] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12345.452419] alg: No test for adler32 (adler32-zlib) [12346.540432] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [12346.805219] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [12348.502110] Key type lgssc registered [12349.921992] Lustre: Echo OBD driver; http://www.lustre.org/ [12408.092262] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12413.542541] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12433.628633] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12436.283659] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [12455.245753] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12457.609851] Lustre: Unmounted lustre-client [12479.323910] Key type lgssc unregistered [12479.595908] LNet: 270483:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12479.607992] LNetError: 270483:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12479.625538] LNet: Removed LNI 192.168.202.32@tcp [12480.306746] Key type .llcrypt unregistered [12480.308706] Key type ._llcrypt unregistered [12496.028507] Key type ._llcrypt registered [12496.036982] Key type .llcrypt registered [12497.525779] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 08:17:48 (1789647468) [12515.395238] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12515.416252] alg: No test for adler32 (adler32-zlib) [12516.586512] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [12516.815887] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [12518.561678] Key type lgssc registered [12520.048951] Lustre: Echo OBD driver; http://www.lustre.org/ [12642.399428] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12645.083621] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [12691.431223] Lustre: lustre-MDT0001-mdc-ffff99decace7800: Connection to lustre-MDT0001 (at 192.168.202.132@tcp) was lost; in progress operations using this service will wait for recovery to complete [12702.450749] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12712.835411] Lustre: Unmounted lustre-client [12741.086592] Key type lgssc unregistered [12741.365644] LNet: 276273:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12741.380910] LNetError: 276273:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12741.402337] LNet: Removed LNI 192.168.202.32@tcp [12742.262184] Key type .llcrypt unregistered [12742.266832] Key type ._llcrypt unregistered [12761.012408] Key type ._llcrypt registered [12761.013977] Key type .llcrypt registered [12762.492995] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 08:22:13 (1789647733) [12764.364291] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12766.632262] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 08:22:17 (1789647737) [12768.612682] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12770.770783] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 08:22:21 (1789647741) [12773.288417] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12775.980719] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 08:22:26 (1789647746) [12777.492667] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12779.483526] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 08:22:30 (1789647750) [12781.157113] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12782.793024] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 08:22:34 (1789647754) [12792.744953] Key type .llcrypt unregistered [12792.746639] Key type ._llcrypt unregistered [12802.080715] Key type ._llcrypt registered [12802.084854] Key type .llcrypt registered [12802.767902] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12802.801238] alg: No test for adler32 (adler32-zlib) [12803.980276] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [12804.243270] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [12805.895304] Key type lgssc registered [12807.800482] Lustre: Echo OBD driver; http://www.lustre.org/ [12887.377411] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12895.196834] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12918.471334] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12920.272729] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [12923.313646] Lustre: Unmounted lustre-client [12951.137965] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 08:25:22 (1789647922) [12993.491593] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13000.875729] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13039.394980] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13040.330610] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [13044.039145] Lustre: Unmounted lustre-client [13088.548678] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 08:27:40 (1789648060) [13094.047558] LNet: 1 local NIs in recovery (showing 1): 192.168.202.32@tcp [13747.187808] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13753.945858] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13791.595473] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13901.768426] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 08:41:13 (1789648873) [13914.339860] Key type lgssc unregistered [13914.592360] LNet: 289803:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13914.599543] LNetError: 289803:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13914.619316] LNet: Removed LNI 192.168.202.32@tcp [13915.398610] Key type .llcrypt unregistered [13915.400643] Key type ._llcrypt unregistered [14042.559508] Key type ._llcrypt registered [14042.564716] Key type .llcrypt registered [14043.292291] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14043.314272] alg: No test for adler32 (adler32-zlib) [14044.518436] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [14044.745518] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [14046.495773] Key type lgssc registered [14047.937943] Lustre: Echo OBD driver; http://www.lustre.org/ [14143.362896] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14150.486211] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14183.847647] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14236.582632] Key type lgssc unregistered [14236.899737] LNet: 293506:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14236.910183] LNetError: 293506:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14236.920126] LNet: Removed LNI 192.168.202.32@tcp [14237.881766] Key type .llcrypt unregistered [14237.884901] Key type ._llcrypt unregistered [14277.367315] Key type ._llcrypt registered [14277.369990] Key type .llcrypt registered [14279.160875] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 08:47:30 (1789649250) [14302.907601] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14302.956318] alg: No test for adler32 (adler32-zlib) [14304.053825] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [14304.326072] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [14306.143355] Key type lgssc registered [14307.795875] Lustre: Echo OBD driver; http://www.lustre.org/ [14367.476877] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 08:48:58 (1789649338) [14381.139784] Key type lgssc unregistered [14381.466989] LNet: 297063:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14381.474241] LNetError: 297063:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14381.504139] LNet: Removed LNI 192.168.202.32@tcp [14382.187834] Key type .llcrypt unregistered [14382.190401] Key type ._llcrypt unregistered [14393.655982] Key type ._llcrypt registered [14393.662996] Key type .llcrypt registered [14394.026399] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14394.042701] alg: No test for adler32 (adler32-zlib) [14395.082474] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [14395.281086] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [14396.951236] Key type lgssc registered [14398.237143] Lustre: Echo OBD driver; http://www.lustre.org/ [14464.668173] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14470.412590] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14493.367481] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14844.946864] LNet: Added LNI 192.168.202.32@tcp50 [8/256/0/180] [14847.580579] LNet: Removed LNI 192.168.202.32@tcp [14849.949705] Lustre: 301479:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff99dec58cb800: config has no valid NIDs, force dynamic NIDs [14851.250845] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [14851.441397] Lustre: Unmounted lustre-client [14854.675851] Key type lgssc unregistered [14855.100295] LNet: 301734:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14855.110391] LNetError: 301734:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14856.177402] LNet: Removed LNI 192.168.202.32@tcp50 [14857.046346] Key type .llcrypt unregistered [14857.047812] Key type ._llcrypt unregistered [14882.277083] Key type ._llcrypt registered [14882.279123] Key type .llcrypt registered [14882.742348] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14882.780345] alg: No test for adler32 (adler32-zlib) [14884.099083] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [14884.382936] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [14886.216160] Key type lgssc registered [14888.123472] Lustre: Echo OBD driver; http://www.lustre.org/ [14955.298299] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14964.352622] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14976.791720] LNet: Added LNI 192.168.202.32@tcp50 [8/256/0/180] [14977.328047] LNet: Removed LNI 192.168.202.32@tcp [14978.528075] Lustre: 304421:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff99decace2800: config has no valid NIDs, force dynamic NIDs [14979.814350] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [14980.805867] Lustre: Unmounted lustre-client [15028.836161] Key type lgssc unregistered [15029.166413] LNet: 305290:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15029.175631] LNetError: 305290:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15029.190873] LNet: Removed LNI 192.168.202.32@tcp50 [15030.138407] Key type .llcrypt unregistered [15030.140858] Key type ._llcrypt unregistered [15045.381639] Key type ._llcrypt registered [15045.383967] Key type .llcrypt registered [15046.874910] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 09:00:18 (1789650018) [15069.705030] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15069.757783] alg: No test for adler32 (adler32-zlib) [15070.848990] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [15071.190041] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [15072.946258] Key type lgssc registered [15074.892500] Lustre: Echo OBD driver; http://www.lustre.org/ [15193.742504] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15199.465915] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15229.194251] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15267.052753] Key type lgssc unregistered [15267.357539] LNet: 310055:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15267.391177] LNetError: 310055:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15267.428215] LNet: Removed LNI 192.168.202.32@tcp [15268.244422] Key type .llcrypt unregistered [15268.246845] Key type ._llcrypt unregistered [15282.275577] Key type ._llcrypt registered [15282.282762] Key type .llcrypt registered [15283.948951] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 09:04:15 (1789650255) [15287.065728] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15287.132840] alg: No test for adler32 (adler32-zlib) [15288.337503] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [15288.735609] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [15290.503253] Key type lgssc registered [15292.363976] Lustre: Echo OBD driver; http://www.lustre.org/ [15360.443643] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15369.238116] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15401.264412] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15404.721585] Lustre: Mounted lustre-client - version 2.17.58_39_ga8a99f2 [15471.757193] Lustre: Mounted fs15246-client - version 2.17.58_39_ga8a99f2 [15489.836092] Lustre: Unmounted fs15246-client [15523.484778] Lustre: Unmounted lustre-client [15557.598731] Key type lgssc unregistered [15557.982223] LNet: 314920:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15557.990698] LNetError: 314920:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15558.027505] LNet: Removed LNI 192.168.202.32@tcp [15558.840190] Key type .llcrypt unregistered [15558.842920] Key type ._llcrypt unregistered [15569.974894] Key type ._llcrypt registered [15569.978212] Key type .llcrypt registered [15571.792846] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 09:09:02 (1789650542) [15573.925023] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15573.937079] alg: No test for adler32 (adler32-zlib) [15575.058799] Lustre: Lustre: Build Version: 2.17.58_39_ga8a99f2 [15575.306563] LNet: Added LNI 192.168.202.32@tcp [8/256/0/180] [15576.976841] Key type lgssc registered [15578.442408] Lustre: Echo OBD driver; http://www.lustre.org/ [15733.715314] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15740.074834] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15764.603151] Lustre: DEBUG MARKER: oleg232-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15878.912514] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15546 sec ========= 09:14:10 (1789650850) [15880.777661] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 09:14:12 (1789650852) === [15884.084661] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 09:14:15 (1789650855) === [15913.167736] Key type lgssc unregistered [15913.368934] LNet: 324188:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15913.373612] LNetError: 324188:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15913.391242] LNet: Removed LNI 192.168.202.32@tcp [15914.012749] Key type .llcrypt unregistered [15914.014937] Key type ._llcrypt unregistered