[ 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 424624631 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, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001023] APIC: Switch to symmetric I/O mode setup [ 0.002320] x2apic enabled [ 0.003009] Switched APIC routing to physical x2apic. [ 0.004016] kvm-guest: setup PV IPIs [ 0.007482] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009016] pid_max: default: 32768 minimum: 301 [ 0.010131] LSM: Security Framework initializing [ 0.011063] Yama: becoming mindful. [ 0.012050] SELinux: Initializing. [ 0.013087] *** VALIDATE selinux *** [ 0.021267] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026618] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027162] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028121] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029119] *** VALIDATE tmpfs *** [ 0.031438] *** VALIDATE proc *** [ 0.032251] *** VALIDATE cgroup *** [ 0.033012] *** VALIDATE cgroup2 *** [ 0.034286] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035159] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037033] Spectre V2 : User space: Vulnerable [ 0.038011] Speculative Store Bypass: Vulnerable [ 0.040912] debug: unmapping init [mem 0xffffffffa9459000-0xffffffffa9460fff] [ 0.042174] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043710] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044027] ... version: 2 [ 0.045015] ... bit width: 48 [ 0.046013] ... generic registers: 4 [ 0.047014] ... value mask: 0000ffffffffffff [ 0.048015] ... max period: 00007fffffffffff [ 0.049015] ... fixed-purpose events: 3 [ 0.050012] ... event mask: 000000070000000f [ 0.051305] rcu: Hierarchical SRCU implementation. [ 0.053411] smp: Bringing up secondary CPUs ... [ 0.054600] x86: Booting SMP configuration: [ 0.055029] .... node #0, CPUs: #1 #2 #3 [ 0.065080] smp: Brought up 1 node, 4 CPUs [ 0.067020] smpboot: Max logical packages: 1 [ 0.068013] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.122761] node 0 deferred pages initialised in 52ms [ 0.126160] devtmpfs: initialized [ 0.127290] x86/mm: Memory block size: 128MB [ 0.131774] gcov: version magic: 0x41383552 [ 0.135335] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.136087] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.137312] pinctrl core: initialized pinctrl subsystem [ 0.139257] [ 0.139761] ************************************************************* [ 0.142013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.144010] ** ** [ 0.146012] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.148011] ** ** [ 0.150009] ** This means that this kernel is built to expose internal ** [ 0.152013] ** IOMMU data structures, which may compromise security on ** [ 0.154012] ** your system. ** [ 0.157023] ** ** [ 0.158010] ** If you see this message and you are not debugging the ** [ 0.160059] ** kernel, report this immediately to your vendor! ** [ 0.163011] ** ** [ 0.165011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.167012] ************************************************************* [ 0.169755] NET: Registered protocol family 16 [ 0.171475] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.172054] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.175059] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.178169] cpuidle: using governor menu [ 0.180966] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.183702] PCI: Using configuration type 1 for base access [ 0.186150] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.197330] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.199141] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.203224] cryptd: max_cpu_qlen set to 1000 [ 0.206243] ACPI: Added _OSI(Module Device) [ 0.208022] ACPI: Added _OSI(Processor Device) [ 0.209021] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.211024] ACPI: Added _OSI(Processor Aggregator Device) [ 0.216149] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.221255] ACPI: Interpreter enabled [ 0.222055] ACPI: PM: (supports S0 S3 S4 S5) [ 0.223013] ACPI: Using IOAPIC for interrupt routing [ 0.224105] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.227555] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.237744] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.240044] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.244019] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.246115] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.251542] acpiphp: Slot [2] registered [ 0.253150] acpiphp: Slot [5] registered [ 0.255147] acpiphp: Slot [6] registered [ 0.256162] acpiphp: Slot [3] registered [ 0.258182] acpiphp: Slot [4] registered [ 0.260132] acpiphp: Slot [7] registered [ 0.261119] acpiphp: Slot [8] registered [ 0.262093] acpiphp: Slot [9] registered [ 0.264130] acpiphp: Slot [10] registered [ 0.265113] acpiphp: Slot [11] registered [ 0.267139] acpiphp: Slot [12] registered [ 0.269127] acpiphp: Slot [13] registered [ 0.270082] acpiphp: Slot [14] registered [ 0.272105] acpiphp: Slot [15] registered [ 0.273114] acpiphp: Slot [16] registered [ 0.275130] acpiphp: Slot [17] registered [ 0.276124] acpiphp: Slot [18] registered [ 0.278134] acpiphp: Slot [19] registered [ 0.279133] acpiphp: Slot [20] registered [ 0.281135] acpiphp: Slot [21] registered [ 0.283122] acpiphp: Slot [22] registered [ 0.285132] acpiphp: Slot [23] registered [ 0.286147] acpiphp: Slot [24] registered [ 0.287150] acpiphp: Slot [25] registered [ 0.289089] acpiphp: Slot [26] registered [ 0.290054] acpiphp: Slot [27] registered [ 0.291121] acpiphp: Slot [28] registered [ 0.292164] acpiphp: Slot [29] registered [ 0.294105] acpiphp: Slot [30] registered [ 0.295122] acpiphp: Slot [31] registered [ 0.296172] PCI host bridge to bus 0000:00 [ 0.298032] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.300037] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.303117] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.308044] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.310035] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.312029] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.314208] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.317225] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.321457] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.328974] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.333050] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.337030] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.339031] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.342028] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.345401] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.347878] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.351048] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.354931] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.359014] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.368015] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.371000] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.375165] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.380921] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.384977] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.398016] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.406618] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.413021] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.418021] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.434022] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.445948] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.449645] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.451533] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.455413] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.458233] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.463115] iommu: Default domain type: Passthrough [ 0.465488] SCSI subsystem initialized [ 0.467161] ACPI: bus type USB registered [ 0.468106] usbcore: registered new interface driver usbfs [ 0.471084] usbcore: registered new interface driver hub [ 0.473104] usbcore: registered new device driver usb [ 0.475178] pps_core: LinuxPPS API ver. 1 registered [ 0.477011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.480080] PTP clock support registered [ 0.483049] EDAC MC: Ver: 3.0.0 [ 0.485433] PCI: Using ACPI for IRQ routing [ 0.487780] NetLabel: Initializing [ 0.489009] NetLabel: domain hash size = 128 [ 0.490009] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.492076] NetLabel: unlabeled traffic allowed by default [ 0.495099] vgaarb: loaded [ 0.496254] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.499016] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.507128] clocksource: Switched to clocksource kvm-clock [ 0.620464] VFS: Disk quotas dquot_6.6.0 [ 0.623149] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.625399] *** VALIDATE ramfs *** [ 0.626522] *** VALIDATE hugetlbfs *** [ 0.628495] pnp: PnP ACPI init [ 0.631248] pnp: PnP ACPI: found 6 devices [ 0.657048] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.660114] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.663051] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.666563] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.670283] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.674434] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.679192] NET: Registered protocol family 2 [ 0.682333] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.688365] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.692846] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.698632] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.702526] TCP: Hash tables configured (established 65536 bind 65536) [ 0.705839] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.709441] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.711236] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.713321] NET: Registered protocol family 1 [ 0.715728] RPC: Registered named UNIX socket transport module. [ 0.718186] RPC: Registered udp transport module. [ 0.719549] RPC: Registered tcp transport module. [ 0.721357] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.723569] NET: Registered protocol family 44 [ 0.724647] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.726227] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.728697] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.730749] PCI: CLS 0 bytes, default 64 [ 0.732218] Unpacking initramfs... [ 2.142537] debug: unmapping init [mem 0xffff894bbcc64000-0xffff894bbffcffff] [ 2.146487] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.148851] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.152857] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.649589] Initialise system trusted keyrings [ 2.652441] Key type blacklist registered [ 2.655401] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.666629] zbud: loaded [ 2.702313] *** VALIDATE nfs *** [ 2.705027] *** VALIDATE nfs4 *** [ 2.708405] pstore: using deflate compression [ 2.712270] Platform Keyring initialized [ 2.819483] NET: Registered protocol family 38 [ 2.821041] Key type asymmetric registered [ 2.822532] Asymmetric key parser 'x509' registered [ 2.824606] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.828044] io scheduler mq-deadline registered [ 2.829694] io scheduler kyber registered [ 2.831444] io scheduler bfq registered [ 2.833714] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.836101] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.838459] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.841231] ACPI: Power Button [PWRF] [ 2.845681] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.851720] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.860906] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.887782] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.915064] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.919511] Non-volatile memory driver v1.3 [ 2.921234] Linux agpgart interface v0.103 [ 2.951638] virtio_blk virtio1: [vda] 146680 512-byte logical blocks (75.1 MB/71.6 MiB) [ 2.955232] vda: detected capacity change from 0 to 75100160 [ 2.968846] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.972110] vdb: detected capacity change from 0 to 1073741824 [ 2.982415] libphy: Fixed MDIO Bus: probed [ 2.990295] usbcore: registered new interface driver usbserial_generic [ 2.993672] usbserial: USB Serial support registered for generic [ 2.996770] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.001565] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.003698] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.006054] mousedev: PS/2 mouse device common for all mice [ 3.010446] rtc_cmos 00:05: RTC can wake from S4 [ 3.012841] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.013515] rtc_cmos 00:05: registered as rtc0 [ 3.018202] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.021157] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.021848] intel_pstate: CPU model not supported [ 3.025944] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.029746] hid: raw HID events driver (C) Jiri Kosina [ 3.032172] usbcore: registered new interface driver usbhid [ 3.034326] usbhid: USB HID core driver [ 3.036294] drop_monitor: Initializing network drop monitor service [ 3.038422] Initializing XFRM netlink socket [ 3.040627] NET: Registered protocol family 10 [ 3.044373] Segment Routing with IPv6 [ 3.046247] NET: Registered protocol family 17 [ 3.048589] mpls_gso: MPLS GSO support [ 3.055395] RAS: Correctable Errors collector initialized. [ 3.058235] AVX version of gcm_enc/dec engaged. [ 3.059958] AES CTR mode by8 optimization enabled [ 3.137384] sched_clock: Marking stable (3137365129, 0)->(4050104836, -912739707) [ 3.141326] registered taskstats version 1 [ 3.143237] Loading compiled-in X.509 certificates [ 3.145105] zswap: loaded using pool lzo/zbud [ 3.169190] Key type big_key registered [ 3.180125] Key type encrypted registered [ 3.181660] ima: No TPM chip found, activating TPM-bypass! [ 3.183814] ima: Allocated hash algorithm: sha1 [ 3.185370] ima: No architecture policies found [ 3.188498] evm: Initialising EVM extended attributes: [ 3.190284] evm: security.selinux [ 3.191372] evm: security.ima [ 3.192374] evm: security.capability [ 3.193494] evm: HMAC attrs: 0x1 [ 3.197162] rtc_cmos 00:05: setting system clock to 2026-09-05 04:21:46 UTC (1788582106) [ 3.203457] debug: unmapping init [mem 0xffffffffaa403000-0xffffffffaa5fffff] [ 3.207153] debug: unmapping init [mem 0xffffffffa9182000-0xffffffffa9458fff] [ 3.216178] Write protecting the kernel read-only data: 28672k [ 3.219689] debug: unmapping init [mem 0xffffffffa7803000-0xffffffffa79fffff] [ 3.223581] debug: unmapping init [mem 0xffffffffa8114000-0xffffffffa81fffff] [ 3.254963] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.263909] systemd[1]: Detected virtualization kvm. [ 3.265805] systemd[1]: Detected architecture x86-64. [ 3.267568] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.297491] systemd[1]: No hostname configured. [ 3.298959] systemd[1]: Set hostname to . [ 3.300848] random: systemd: uninitialized urandom read (16 bytes read) [ 3.303058] systemd[1]: Initializing machine ID from random generator. [ 3.349832] random: ln: uninitialized urandom read (6 bytes read) [ 3.428539] random: systemd: uninitialized urandom read (16 bytes read) [ 3.432058] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.440271] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.449566] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... [ OK ] Reached target Initrd Root Device. Starting Setup Virtual Console... Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Sockets. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.112752] device-mapper: uevent: version 1.0.3 [ 4.114766] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ 4.830728] random: fast init done [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.888041] virtio_net virtio0 ens2: renamed from eth0 [ 4.989266] scsi host0: ata_piix [ 5.061737] scsi host1: ata_piix [ 5.063093] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.065294] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.727523] dracut-initqueue[581]: RTNETLINK answers: File exists [ 9.699562] random: crng init done [ 9.701185] random: 7 urandom warning(s) missed due to ratelimiting 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... [ 10.205432] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.485553] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.764543] SELinux: Disabled at runtime. [ 11.843714] 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) [ 11.850769] systemd[1]: Detected virtualization kvm. [ 11.853135] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.371857] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.375721] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.380918] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.385275] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.389167] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.399436] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.410974] systemd[1]: Mounting Kernel Debug File System... Mounting Kernel Debug File System... [ OK ] Created slice system-serial\x2dgetty.slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on udev Kernel Socket. Activating swap /dev/disk/by-label/SWAP... [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Mounting POSIX Message Queue File System... [ OK ] Created slic[ 12.479614] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS e system-getty.slice. Starting Create list of required st…ce nodes for the current kernel... Mounting Huge Pages File System... [ OK ] Listening on initctl Compatibility Named Pipe. Starting Apply Kernel Variables... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Listening on Process Core Dump Socket. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Started Journal Service. [ OK ] Mounted Kernel Debug File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.880039] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.232303] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.238321] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.342947] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.360324] EDAC sbridge: Ver: 1.1.2 [ 14.436423] Key type dns_resolver registered [ 14.741831] NFS: Registering the id_resolver key type [ 14.744083] Key type id_resolver registered [ 14.747405] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. Starting Restore /run/initramfs on shutdown... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Started OpenSSH server daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg304-client login: [ 42.923545] libcfs: loading out-of-tree module taints kernel. [ 42.954151] Key type ._llcrypt registered [ 42.955912] Key type .llcrypt registered [ 43.184555] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 43.192668] alg: No test for adler32 (adler32-zlib) [ 44.250961] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 44.620569] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 46.263193] Key type lgssc registered [ 47.047523] Lustre: Echo OBD driver; http://www.lustre.org/ [ 223.187291] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 228.544103] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 236.135029] hrtimer: interrupt took 8891380 ns [ 242.783675] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing check_logdir /tmp/testlogs/ [ 247.077482] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing yml_node [ 248.802055] Lustre: lustre-OST0000-osc-ffff894c18449800: disconnect after 23s idle [ 251.832907] Lustre: DEBUG MARKER: Client: 2.17.57.104 [ 254.557531] Lustre: DEBUG MARKER: MDS: 2.17.57.104 [ 257.390773] Lustre: DEBUG MARKER: OSS: 2.17.57.104 [ 259.221529] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sat Sep 5 00:26:01 EDT 2026 [ 276.769513] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 277.869617] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 280.154894] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 290.475087] Lustre: Unmounted lustre-client [ 406.554486] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 413.150629] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 436.512825] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 476.016284] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 00:29:37 (1788582577) [ 478.732623] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 481.115763] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 00:29:42 (1788582582) [ 515.445371] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 520.847638] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 541.257547] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 541.733462] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 545.408399] Lustre: Unmounted lustre-client [ 580.505647] Key type lgssc unregistered [ 580.777699] LNet: 15049:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 580.783785] LNetError: 15049:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 580.798435] LNet: Removed LNI 192.168.203.4@tcp [ 581.578175] Key type .llcrypt unregistered [ 581.580496] Key type ._llcrypt unregistered [ 597.404203] Key type ._llcrypt registered [ 597.408881] Key type .llcrypt registered [ 598.917576] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 00:31:40 (1788582700) [ 600.814618] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 600.844356] alg: No test for adler32 (adler32-zlib) [ 602.131295] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 602.486438] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 604.231292] Key type lgssc registered [ 606.166117] Lustre: Echo OBD driver; http://www.lustre.org/ [ 684.584837] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 774.394312] Lustre: Unmounted lustre-client [ 801.758973] Key type lgssc unregistered [ 802.013496] LNet: 18887:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 802.023336] LNetError: 18887:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 802.040040] LNet: Removed LNI 192.168.203.4@tcp [ 802.690334] Key type .llcrypt unregistered [ 802.692326] Key type ._llcrypt unregistered [ 811.329556] Key type ._llcrypt registered [ 811.345510] Key type .llcrypt registered [ 812.572717] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 00:35:14 (1788582914) [ 814.508860] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 814.538576] alg: No test for adler32 (adler32-zlib) [ 815.621369] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 815.937699] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 817.623198] Key type lgssc registered [ 818.697365] Lustre: Echo OBD driver; http://www.lustre.org/ [ 862.871566] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 868.461340] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 887.654662] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 889.147463] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 899.435065] Lustre: Unmounted lustre-client [ 932.259384] Key type lgssc unregistered [ 932.508647] LNet: 22483:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 932.516329] LNetError: 22483:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 932.531509] LNet: Removed LNI 192.168.203.4@tcp [ 933.055395] Key type .llcrypt unregistered [ 933.059435] Key type ._llcrypt unregistered [ 942.343221] Key type ._llcrypt registered [ 942.346902] Key type .llcrypt registered [ 943.390307] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 00:37:25 (1788583045) [ 945.013274] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 945.085756] alg: No test for adler32 (adler32-zlib) [ 946.129467] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 946.338515] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 948.031183] Key type lgssc registered [ 949.432122] Lustre: Echo OBD driver; http://www.lustre.org/ [ 997.465809] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1002.471568] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1021.607439] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1023.260983] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 1037.177718] Lustre: Unmounted lustre-client [ 1072.765583] Key type lgssc unregistered [ 1073.064959] LNet: 25674:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1073.074773] LNetError: 25674:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1073.090547] LNet: Removed LNI 192.168.203.4@tcp [ 1073.781339] Key type .llcrypt unregistered [ 1073.783569] Key type ._llcrypt unregistered [ 1088.890913] Key type ._llcrypt registered [ 1088.893187] Key type .llcrypt registered [ 1090.260941] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 00:39:51 (1788583191) [ 1094.090421] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1094.121143] alg: No test for adler32 (adler32-zlib) [ 1095.668692] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 1096.071880] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 1097.800089] Key type lgssc registered [ 1099.481349] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1152.979713] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1157.886261] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1175.817716] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1178.350648] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 1183.730653] Lustre: lustre-MDT0000-mdc-ffff894c095ed000: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1188.858270] Lustre: lustre-MDT0001-mdc-ffff894c095ed000: Connection to lustre-MDT0001 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1196.231085] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1205.215652] Lustre: 26631:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788583292/real 1788583292] req@0000000045718079 x1875465416480256/t0(0) o400->MGC192.168.203.104@tcp@192.168.203.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1788583308 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1205.252195] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [ 1206.575052] Lustre: Unmounted lustre-client [ 1232.884384] Key type lgssc unregistered [ 1233.183702] LNet: 29330:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1233.193724] LNetError: 29330:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1233.218710] LNet: Removed LNI 192.168.203.4@tcp [ 1233.879321] Key type .llcrypt unregistered [ 1233.881224] Key type ._llcrypt unregistered [ 1248.582698] Key type ._llcrypt registered [ 1248.585530] Key type .llcrypt registered [ 1249.895290] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 00:42:31 (1788583351) [ 1251.760608] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1251.852452] alg: No test for adler32 (adler32-zlib) [ 1253.004590] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 1253.232742] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 1254.887508] Key type lgssc registered [ 1255.980785] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1307.075422] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1312.732232] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1332.887611] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1335.464582] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 1340.912948] Lustre: lustre-OST0000-osc-ffff894c1000b000: Connection to lustre-OST0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1346.866270] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1357.294565] Lustre: Unmounted lustre-client [ 1383.335508] Key type lgssc unregistered [ 1383.606731] LNet: 32936:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1383.616229] LNetError: 32936:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1383.633425] LNet: Removed LNI 192.168.203.4@tcp [ 1384.535495] Key type .llcrypt unregistered [ 1384.539113] Key type ._llcrypt unregistered [ 1398.824493] Key type ._llcrypt registered [ 1398.829036] Key type .llcrypt registered [ 1400.174615] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 00:45:01 (1788583501) [ 1402.447753] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1402.466405] alg: No test for adler32 (adler32-zlib) [ 1403.522870] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 1403.712892] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 1405.368055] Key type lgssc registered [ 1406.276958] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1446.396475] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1450.777922] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1468.332460] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1474.143656] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 1477.767449] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1480.624630] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1492.097238] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-05 0h46m34s [ 1494.025743] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1499.629215] Lustre: lustre-MDT0000-mdc-ffff894c07d17000: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1504.122125] LustreError: 36721:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff894c07d17000: can't stat MDS #0: rc = -19 [ 1505.604494] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1517.033664] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [ 1517.052328] Lustre: Evicted from MGS (at 192.168.203.104@tcp) after server handle changed from 0xb48837b10b5d9630 to 0xb48837b10b5d99d3 [ 1517.066128] Lustre: MGC192.168.203.104@tcp: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 1518.158022] LustreError: lustre-MDT0000-mdc-ffff894c07d17000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1518.170753] Lustre: lustre-MDT0000-mdc-ffff894c07d17000: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 1519.988282] Lustre: DEBUG MARKER: Wait for df (36721) ... [ 1521.507833] Lustre: DEBUG MARKER: done [ 1523.801435] Lustre: Unmounted lustre-client [ 1550.041579] Key type lgssc unregistered [ 1550.285844] LNet: 37738:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1550.291973] LNetError: 37738:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1550.311323] LNet: Removed LNI 192.168.203.4@tcp [ 1550.993853] Key type .llcrypt unregistered [ 1550.998388] Key type ._llcrypt unregistered [ 1580.666492] Key type ._llcrypt registered [ 1580.670152] Key type .llcrypt registered [ 1581.761767] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 00:48:03 (1788583683) [ 1584.086759] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1584.145829] alg: No test for adler32 (adler32-zlib) [ 1585.192956] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 1585.487299] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 1587.184197] Key type lgssc registered [ 1588.463657] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1630.877773] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1635.787407] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1654.993717] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1657.653684] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 1661.515186] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-05 0h49m23s [ 1663.043301] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1669.174616] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1671.449377] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1691.615464] Lustre: 41885:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788583774/real 1788583774] req@000000005833e0a5 x1875465929234688/t0(0) o101->lustre-MDT0000-mdc-ffff894c06961800@192.168.203.104@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788583794 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1691.645301] Lustre: lustre-MDT0000-mdc-ffff894c06961800: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1691.685114] Lustre: lustre-MDT0000-mdc-ffff894c06961800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 1712.827355] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1715.486760] Lustre: DEBUG MARKER: done [ 1718.353420] Lustre: Unmounted lustre-client [ 1752.012847] Key type lgssc unregistered [ 1752.280182] LNet: 42762:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1752.290416] LNetError: 42762:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1752.302450] LNet: Removed LNI 192.168.203.4@tcp [ 1752.962759] Key type .llcrypt unregistered [ 1752.965195] Key type ._llcrypt unregistered [ 1779.695320] Key type ._llcrypt registered [ 1779.698315] Key type .llcrypt registered [ 1780.802590] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 00:51:22 (1788583882) [ 1782.057782] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1784.110992] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 00:51:25 (1788583885) [ 1788.328303] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1788.420633] alg: No test for adler32 (adler32-zlib) [ 1789.719617] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 1790.040751] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 1791.727208] Key type lgssc registered [ 1793.018228] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1819.266370] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 00:52:00 (1788583920) [ 1852.097559] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1858.710184] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1882.205879] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1885.082834] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 1889.297967] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1893.633144] Lustre: Unmounted lustre-client [ 1911.730830] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1959.808484] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1966.650596] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1967.470068] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 1973.108749] Lustre: Unmounted lustre-client [ 2036.975940] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2042.694671] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2043.676561] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 2047.265243] Lustre: Unmounted lustre-client [ 2063.922917] Lustre: DEBUG MARKER: files compared the same [ 2086.852884] Key type lgssc unregistered [ 2087.065880] LNet: 50382:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2087.084490] LNetError: 50382:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2087.105766] LNet: Removed LNI 192.168.203.4@tcp [ 2087.771709] Key type .llcrypt unregistered [ 2087.773325] Key type ._llcrypt unregistered [ 2102.642422] Key type ._llcrypt registered [ 2102.644499] Key type .llcrypt registered [ 2104.036610] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 00:56:45 (1788584205) [ 2106.291189] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2106.307136] alg: No test for adler32 (adler32-zlib) [ 2107.372802] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 2107.622486] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 2109.311423] Key type lgssc registered [ 2110.778406] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2160.395953] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2167.162571] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2189.494682] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2192.183783] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 2199.550993] Lustre: Unmounted lustre-client [ 2228.115619] Key type lgssc unregistered [ 2228.306249] LNet: 53960:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2228.320440] LNetError: 53960:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2228.341555] LNet: Removed LNI 192.168.203.4@tcp [ 2229.108568] Key type .llcrypt unregistered [ 2229.112293] Key type ._llcrypt unregistered [ 2244.648340] Key type ._llcrypt registered [ 2244.651903] Key type .llcrypt registered [ 2245.727038] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 00:59:07 (1788584347) [ 2247.772477] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2247.787451] alg: No test for adler32 (adler32-zlib) [ 2248.844717] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 2249.106689] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 2250.807186] Key type lgssc registered [ 2252.136883] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2332.768325] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2370.418454] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2376.049179] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2401.000842] Key type lgssc unregistered [ 2401.225372] LNet: 57456:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2401.231262] LNetError: 57456:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2401.241713] LNet: Removed LNI 192.168.203.4@tcp [ 2401.797879] Key type .llcrypt unregistered [ 2401.801882] Key type ._llcrypt unregistered [ 2416.145817] Key type ._llcrypt registered [ 2416.150031] Key type .llcrypt registered [ 2417.637644] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 01:01:59 (1788584519) [ 2420.650617] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2420.675049] alg: No test for adler32 (adler32-zlib) [ 2421.721148] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 2421.925343] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 2423.615185] Key type lgssc registered [ 2424.830666] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2495.717086] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 2503.220874] Lustre: Unmounted lustre-client [ 2542.759913] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 01:04:04 (1788584644) [ 2661.744685] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2682.992077] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 2691.007666] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2691.012309] LustreError: 63934:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff894c077e9000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2691.028232] Lustre: 58440:0:(llite_lib.c:4343:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.104@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2701.389968] Lustre: Unmounted lustre-client [ 2758.995630] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 01:07:40 (1788584860) [ 2772.006628] Key type lgssc unregistered [ 2772.326389] LNet: 65147:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2772.340563] LNetError: 65147:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2772.375600] LNet: Removed LNI 192.168.203.4@tcp [ 2773.232481] Key type .llcrypt unregistered [ 2773.235838] Key type ._llcrypt unregistered [ 2786.981702] Key type ._llcrypt registered [ 2786.985033] Key type .llcrypt registered [ 2787.569657] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2787.623440] alg: No test for adler32 (adler32-zlib) [ 2788.723887] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 2788.947229] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 2790.687253] Key type lgssc registered [ 2792.010793] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2848.599550] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2855.365853] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2878.429623] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2880.600497] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 2888.584447] Lustre: Unmounted lustre-client [ 2930.071032] Key type lgssc unregistered [ 2930.467293] LNet: 68165:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2930.479033] LNetError: 68165:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2930.526336] LNet: Removed LNI 192.168.203.4@tcp [ 2931.685245] Key type .llcrypt unregistered [ 2931.686957] Key type ._llcrypt unregistered [ 2944.203464] Key type ._llcrypt registered [ 2944.208883] Key type .llcrypt registered [ 2944.759924] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2944.769158] alg: No test for adler32 (adler32-zlib) [ 2945.843386] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 2946.105383] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 2947.816085] Key type lgssc registered [ 2949.258933] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3053.335357] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3060.946943] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3084.752951] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3086.679815] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 3090.015789] Lustre: Unmounted lustre-client [ 3118.634743] Key type lgssc unregistered [ 3118.984957] LNet: 71596:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3119.003961] LNetError: 71596:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3119.042203] LNet: Removed LNI 192.168.203.4@tcp [ 3119.595125] Key type .llcrypt unregistered [ 3119.599583] Key type ._llcrypt unregistered [ 3134.397316] Key type ._llcrypt registered [ 3134.398921] Key type .llcrypt registered [ 3136.260365] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 01:13:57 (1788585237) [ 3138.707741] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3138.748155] alg: No test for adler32 (adler32-zlib) [ 3139.827901] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 3140.102254] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 3141.801965] Key type lgssc registered [ 3143.370721] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3197.519341] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3204.468967] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3227.291758] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3228.946641] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 3238.388733] Lustre: Unmounted lustre-client [ 3238.881037] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 3241.541033] Lustre: Unmounted lustre-client [ 3268.958654] Key type lgssc unregistered [ 3269.307293] LNet: 75296:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3269.317889] LNetError: 75296:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3269.341095] LNet: Removed LNI 192.168.203.4@tcp [ 3269.915754] Key type .llcrypt unregistered [ 3269.919217] Key type ._llcrypt unregistered [ 3281.930944] Key type ._llcrypt registered [ 3281.933652] Key type .llcrypt registered [ 3282.406811] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3282.419538] alg: No test for adler32 (adler32-zlib) [ 3283.486141] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 3283.732233] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 3285.543707] Key type lgssc registered [ 3286.966664] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3349.699708] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3357.943744] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3384.716280] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3390.524653] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 3395.321295] Lustre: Unmounted lustre-client [ 3423.740378] Key type lgssc unregistered [ 3424.060311] LNet: 78329:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3424.074436] LNetError: 78329:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3425.128889] LNet: Removed LNI 192.168.203.4@tcp [ 3425.880991] Key type .llcrypt unregistered [ 3425.883543] Key type ._llcrypt unregistered [ 3440.409301] Key type ._llcrypt registered [ 3440.411759] Key type .llcrypt registered [ 3441.715744] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 01:19:03 (1788585543) [ 3444.119134] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3444.210644] alg: No test for adler32 (adler32-zlib) [ 3445.332507] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 3445.633405] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 3447.423365] Key type lgssc registered [ 3449.310777] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3507.577385] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3513.387803] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3538.415018] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3540.189069] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 3548.515915] Lustre: lustre: root_squash is set to 0:0 [ 3556.367258] Lustre: lustre: nosquash_nids is cleared [ 3556.394593] Lustre: lustre: root_squash is set to 500:500 [ 3566.389865] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.4@tcp 192.168.0.[2,10]@tcp [ 3573.192337] Lustre: lustre: nosquash_nids set to 192.168.203.4/24@tcp [ 3579.954424] Lustre: Unmounted lustre-client [ 3610.579837] Key type lgssc unregistered [ 3610.812877] LNet: 82252:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3610.818717] LNetError: 82252:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3610.836914] LNet: Removed LNI 192.168.203.4@tcp [ 3611.832065] Key type .llcrypt unregistered [ 3611.835442] Key type ._llcrypt unregistered [ 3631.351984] Key type ._llcrypt registered [ 3631.354664] Key type .llcrypt registered [ 3633.292658] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 01:22:14 (1788585734) [ 3636.568819] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3638.668214] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 01:22:20 (1788585740) [ 3641.101159] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3641.143839] alg: No test for adler32 (adler32-zlib) [ 3642.451915] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 3642.844108] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 3644.600377] Key type lgssc registered [ 3645.864608] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3697.211323] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3701.665830] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3722.534358] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3724.168746] Lustre: lustre: root_squash is set to 500:500 [ 3724.204143] Lustre: lustre: nosquash_nids set to 192.168.203.4/24@tcp [ 3725.284768] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 3731.210590] Lustre: Unmounted lustre-client [ 3757.026379] Key type lgssc unregistered [ 3757.230432] LNet: 86220:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3757.244904] LNetError: 86220:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3757.265631] LNet: Removed LNI 192.168.203.4@tcp [ 3757.975090] Key type .llcrypt unregistered [ 3757.980264] Key type ._llcrypt unregistered [ 3773.537752] Key type ._llcrypt registered [ 3773.539448] Key type .llcrypt registered [ 3774.851520] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3776.257399] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 01:24:38 (1788585878) [ 3794.360656] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3794.463608] alg: No test for adler32 (adler32-zlib) [ 3795.503667] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 3795.759575] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 3797.503265] Key type lgssc registered [ 3798.558170] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3888.083236] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3896.303997] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3924.960364] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3998.320621] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4004.149570] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4026.299679] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4040.778834] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 4075.231653] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff894c076f2800.ost_server_uuid 50 [ 4077.028417] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff894c076f2800.ost_server_uuid in IDLE state after 0 sec [ 4077.499080] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 4081.719417] Lustre: Unmounted lustre-client [ 4083.923239] Lustre: Unmounted lustre-client [ 4140.435595] Key type lgssc unregistered [ 4140.752902] LNet: 93890:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4140.785901] LNetError: 93890:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4140.817340] LNet: Removed LNI 192.168.203.4@tcp [ 4141.897646] Key type .llcrypt unregistered [ 4141.905684] Key type ._llcrypt unregistered [ 4177.307061] Key type ._llcrypt registered [ 4177.312275] Key type .llcrypt registered [ 4178.561296] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 01:31:20 (1788586280) [ 4198.716919] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4198.755842] alg: No test for adler32 (adler32-zlib) [ 4199.863842] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 4200.180243] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 4201.855423] Key type lgssc registered [ 4203.352627] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4291.906861] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4296.979940] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4319.090052] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4320.843196] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 4342.239220] Lustre: 95250:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788586429/real 1788586429] req@00000000b1b71531 x1875468671259776/t0(0) o400->lustre-OST0000-osc-ffff894c08f1f800@192.168.203.104@tcp:28/4 lens 224/224 e 0 to 1 dl 1788586445 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4342.292657] Lustre: lustre-OST0000-osc-ffff894c08f1f800: Connection to lustre-OST0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4348.383699] Lustre: 95250:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788586434/real 1788586434] req@00000000135bcc3f x1875468671260288/t0(0) o400->lustre-OST0000-osc-ffff894c08f1f800@192.168.203.104@tcp:28/4 lens 224/224 e 0 to 1 dl 1788586450 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4351.775952] Lustre: 95251:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788586439/real 1788586439] req@00000000a0e51245 x1875468671260800/t0(0) o400->lustre-OST0000-osc-ffff894c08f1f800@192.168.203.104@tcp:28/4 lens 224/224 e 0 to 1 dl 1788586455 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4352.566889] Lustre: lustre-OST0000-osc-ffff894c08f1f800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 4357.599140] Lustre: 95251:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788586444/real 1788586444] req@00000000d7d1ac12 x1875468671261312/t0(0) o400->lustre-OST0000-osc-ffff894c08f1f800@192.168.203.104@tcp:28/4 lens 224/224 e 0 to 1 dl 1788586460 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4357.612131] Lustre: lustre-MDT0000-mdc-ffff894c08f1f800: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4372.959241] Lustre: 95250:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788586460/real 1788586460] req@000000009ea5a047 x1875468671263616/t0(0) o400->MGC192.168.203.104@tcp@192.168.203.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1788586476 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4373.016511] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [ 4383.211554] Lustre: Evicted from MGS (at 192.168.203.104@tcp) after server handle changed from 0x31896b9e13880ff4 to 0x31896b9e13881286 [ 4383.229821] Lustre: MGC192.168.203.104@tcp: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 4388.303603] Lustre: lustre-MDT0000-mdc-ffff894c08f1f800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 4392.990404] Lustre: Unmounted lustre-client [ 4436.917848] Key type lgssc unregistered [ 4437.261709] LNet: 99551:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4437.275905] LNetError: 99551:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4437.304622] LNet: Removed LNI 192.168.203.4@tcp [ 4438.260855] Key type .llcrypt unregistered [ 4438.262930] Key type ._llcrypt unregistered [ 4457.786914] Key type ._llcrypt registered [ 4457.789184] Key type .llcrypt registered [ 4459.281826] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 01:36:00 (1788586560) [ 4473.895799] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4473.911493] alg: No test for adler32 (adler32-zlib) [ 4474.967756] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 4475.244579] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 4476.975192] Key type lgssc registered [ 4478.275456] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4516.188178] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4617.806585] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4622.111106] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4642.458569] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4645.138105] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 4647.140426] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4648.506339] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 01:39:10 (1788586750) [ 4860.530070] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4870.877149] Lustre: Unmounted lustre-client [ 4978.517682] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4984.537327] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5006.492468] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5054.024330] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 01:45:56 (1788587156) [ 5145.418719] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5150.842852] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5171.598345] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5172.055105] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 5176.270443] Lustre: Unmounted lustre-client [ 5212.945220] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 01:48:35 (1788587315) [ 5299.937706] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5305.384213] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5325.793884] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5326.455444] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 5330.882123] Lustre: Unmounted lustre-client [ 5358.290346] Key type lgssc unregistered [ 5358.546518] LNet: 122551:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5358.550255] LNetError: 122551:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5358.569945] LNet: Removed LNI 192.168.203.4@tcp [ 5359.157246] Key type .llcrypt unregistered [ 5359.166073] Key type ._llcrypt unregistered [ 5374.209187] Key type ._llcrypt registered [ 5374.217292] Key type .llcrypt registered [ 5375.505275] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 01:51:17 (1788587477) [ 5377.705869] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5377.746869] alg: No test for adler32 (adler32-zlib) [ 5378.849176] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 5379.095272] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 5380.768715] Key type lgssc registered [ 5381.994150] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5428.711262] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5434.067808] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5453.963707] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5455.664967] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 5469.002676] Lustre: Unmounted lustre-client [ 5494.912437] Key type lgssc unregistered [ 5495.175506] LNet: 126134:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5495.191486] LNetError: 126134:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5495.210979] LNet: Removed LNI 192.168.203.4@tcp [ 5495.858606] Key type .llcrypt unregistered [ 5495.860202] Key type ._llcrypt unregistered [ 5511.043890] Key type ._llcrypt registered [ 5511.049335] Key type .llcrypt registered [ 5512.917145] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 01:53:34 (1788587614) [ 5515.440640] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5515.458169] alg: No test for adler32 (adler32-zlib) [ 5516.593721] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 5516.832947] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 5518.471170] Key type lgssc registered [ 5519.650612] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5570.948812] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5576.383655] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5595.555616] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5597.422117] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 5602.792463] Lustre: lustre-OST0000-osc-ffff894c04fcb800: Connection to lustre-OST0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5614.131262] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff894c04fcb800.ost_server_uuid 50 [ 5615.987133] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5627.518235] Lustre: Unmounted lustre-client [ 5650.453842] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 01:55:52 (1788587752) [ 5683.608880] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5689.157735] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5709.780951] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5730.522212] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5731.058423] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 5736.422852] Lustre: lustre-OST0000-osc-ffff894c1002e000: Connection to lustre-OST0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5769.072931] Lustre: Unmounted lustre-client [ 5818.069579] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 01:58:39 (1788587919) [ 5854.489118] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5859.808306] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5878.527541] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5896.726899] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5897.252752] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 5902.315110] Lustre: lustre-OST0000-osc-ffff894c08e37800: Connection to lustre-OST0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5918.119173] Lustre: Unmounted lustre-client [ 5959.630251] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 02:01:01 (1788588061) [ 6047.978551] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6053.161920] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6074.554750] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6134.461179] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6139.326773] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6158.460968] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6195.259464] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 6236.359198] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6242.177699] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 4 sec [ 6244.160046] Lustre: Unmounted lustre-client [ 6275.524466] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 02:06:17 (1788588377) [ 6310.264577] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6317.031827] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6339.835112] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6376.555098] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6407.823333] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 6452.176266] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6453.753689] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6474.689840] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6485.019119] Lustre: Unmounted lustre-client [ 6549.504682] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 02:10:51 (1788588651) [ 6583.089504] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6589.582062] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6613.286546] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6614.059589] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 6640.545825] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6642.396490] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6658.293328] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff894c07d17000.ost_server_uuid 50 [ 6659.764516] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff894c07d17000.ost_server_uuid in IDLE state after 0 sec [ 6663.764137] Lustre: Unmounted lustre-client [ 6664.123992] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6664.135162] Lustre: Skipped 3 previous similar messages [ 6664.219991] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 6665.284327] LustreError: 149579:0:(sec.c:403:import_sec_validate_get()) import 00000000eea2e1b0 (NEW) with no sec [ 6722.861696] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 02:13:44 (1788588824) [ 6757.479572] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6763.727636] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6788.962671] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6813.896450] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6814.384509] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6814.557182] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 6829.427639] Lustre: Unmounted lustre-client [ 6829.434869] Lustre: Skipped 1 previous similar message [ 6872.107436] Key type lgssc unregistered [ 6872.415397] LNet: 153002:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6872.444199] LNetError: 153002:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6872.471087] LNet: Removed LNI 192.168.203.4@tcp [ 6873.371883] Key type .llcrypt unregistered [ 6873.376169] Key type ._llcrypt unregistered [ 6889.226561] Key type ._llcrypt registered [ 6889.229875] Key type .llcrypt registered [ 6890.415774] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 02:16:32 (1788588992) [ 6891.761734] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6891.814488] alg: No test for adler32 (adler32-zlib) [ 6892.859222] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 6893.095554] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 6894.775500] Key type lgssc registered [ 6896.116587] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6952.425362] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6958.731494] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6978.486633] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6997.670330] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6999.450170] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7000.661233] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 7007.262954] LustreError: lustre-MDT0001-mdc-ffff894c106a5800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7007.283947] Lustre: lustre-MDT0001-mdc-ffff894c106a5800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 7012.674087] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7014.353689] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7035.401763] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7040.054224] Lustre: Unmounted lustre-client [ 7061.436353] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 02:19:23 (1788589163) [ 7152.004558] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7161.142356] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7187.608314] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7188.211427] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 7214.995983] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7216.392708] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7220.210198] Lustre: lustre-OST0001-osc-ffff894c06ad0800: Connection to lustre-OST0001 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7228.724679] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7239.067421] Lustre: Unmounted lustre-client [ 7271.887921] Key type lgssc unregistered [ 7272.137775] LNet: 162612:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7272.152354] LNetError: 162612:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7273.191636] LNet: Removed LNI 192.168.203.4@tcp [ 7273.775149] Key type .llcrypt unregistered [ 7273.777504] Key type ._llcrypt unregistered [ 7306.965583] Key type ._llcrypt registered [ 7306.967960] Key type .llcrypt registered [ 7308.349694] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 02:23:30 (1788589410) [ 7310.598924] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7310.666095] alg: No test for adler32 (adler32-zlib) [ 7311.798198] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 7312.073948] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 7313.839213] Key type lgssc registered [ 7315.273687] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7367.969160] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7372.923393] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7391.411133] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7393.999737] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 7439.688909] Lustre: Unmounted lustre-client [ 7480.597089] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7481.296683] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 7516.868392] Lustre: Unmounted lustre-client [ 7551.994188] Key type lgssc unregistered [ 7552.285950] LNet: 167056:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7552.294246] LNetError: 167056:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7552.333220] LNet: Removed LNI 192.168.203.4@tcp [ 7552.976102] Key type .llcrypt unregistered [ 7552.978583] Key type ._llcrypt unregistered [ 7566.843760] Key type ._llcrypt registered [ 7566.852615] Key type .llcrypt registered [ 7568.204366] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 02:27:49 (1788589669) [ 7570.554326] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7570.722947] alg: No test for adler32 (adler32-zlib) [ 7571.838090] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 7572.124764] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 7573.840123] Key type lgssc registered [ 7575.183299] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7623.413130] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7629.229448] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7651.282485] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7653.999326] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 7672.756774] Lustre: Unmounted lustre-client [ 7700.312382] Key type lgssc unregistered [ 7700.677062] LNet: 170806:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7700.686822] LNetError: 170806:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7700.714717] LNet: Removed LNI 192.168.203.4@tcp [ 7701.401441] Key type .llcrypt unregistered [ 7701.407130] Key type ._llcrypt unregistered [ 7714.217167] Key type ._llcrypt registered [ 7714.225299] Key type .llcrypt registered [ 7714.698247] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7714.711112] alg: No test for adler32 (adler32-zlib) [ 7715.763254] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 7715.993662] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 7717.671193] Key type lgssc registered [ 7718.884450] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7769.996434] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7775.994470] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7796.271354] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7798.103250] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 7805.094365] Lustre: Unmounted lustre-client [ 7829.112289] Key type lgssc unregistered [ 7829.440692] LNet: 173866:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7829.448523] LNetError: 173866:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7829.466943] LNet: Removed LNI 192.168.203.4@tcp [ 7830.263147] Key type .llcrypt unregistered [ 7830.275340] Key type ._llcrypt unregistered [ 7846.551632] Key type ._llcrypt registered [ 7846.554552] Key type .llcrypt registered [ 7847.815824] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 02:32:29 (1788589949) [ 7850.210140] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7850.251992] alg: No test for adler32 (adler32-zlib) [ 7851.369710] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 7851.651938] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 7853.359726] Key type lgssc registered [ 7854.999038] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7914.828469] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7921.102188] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7945.618837] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7952.443924] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 7974.373229] Lustre: Unmounted lustre-client [ 8002.798620] Key type lgssc unregistered [ 8003.111082] LNet: 177615:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8003.126833] LNetError: 177615:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8003.150859] LNet: Removed LNI 192.168.203.4@tcp [ 8003.871892] Key type .llcrypt unregistered [ 8003.877697] Key type ._llcrypt unregistered [ 8016.544647] Key type ._llcrypt registered [ 8016.599124] Key type .llcrypt registered [ 8017.187392] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8017.199468] alg: No test for adler32 (adler32-zlib) [ 8018.219389] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 8018.435540] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 8020.119468] Key type lgssc registered [ 8021.496172] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8076.843235] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8083.391844] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8105.317104] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8108.093757] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 8114.930424] Lustre: Unmounted lustre-client [ 8150.054065] Key type lgssc unregistered [ 8150.329473] LNet: 180677:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8150.339474] LNetError: 180677:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8150.365949] LNet: Removed LNI 192.168.203.4@tcp [ 8151.081140] Key type .llcrypt unregistered [ 8151.092318] Key type ._llcrypt unregistered [ 8167.038402] Key type ._llcrypt registered [ 8167.040444] Key type .llcrypt registered [ 8168.306452] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 02:37:50 (1788590270) [ 8190.909191] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8190.931953] alg: No test for adler32 (adler32-zlib) [ 8192.035796] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 8192.291614] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 8193.983252] Key type lgssc registered [ 8195.402790] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8277.864450] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8284.785829] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8305.387884] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8343.474214] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 02:40:45 (1788590445) [ 8372.522589] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8378.029854] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8401.071091] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8403.569644] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 8409.990078] Lustre: Unmounted lustre-client [ 8437.489944] Key type lgssc unregistered [ 8437.824205] LNet: 187768:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8437.834826] LNetError: 187768:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8438.885876] LNet: Removed LNI 192.168.203.4@tcp [ 8439.560861] Key type .llcrypt unregistered [ 8439.562672] Key type ._llcrypt unregistered [ 8455.302376] Key type ._llcrypt registered [ 8455.305448] Key type .llcrypt registered [ 8456.577647] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8458.103757] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 02:42:40 (1788590560) [ 8473.202859] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8473.221606] alg: No test for adler32 (adler32-zlib) [ 8474.323863] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 8474.547611] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 8476.223153] Key type lgssc registered [ 8477.430697] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8564.075742] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8569.351138] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8591.916512] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8615.038927] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8617.711757] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 8639.999895] Lustre: Unmounted lustre-client [ 8763.497636] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8768.163383] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8791.100587] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8832.926208] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 02:48:55 (1788590935) [ 8834.164436] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8835.643781] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 02:48:57 (1788590937) [ 8921.153484] Key type lgssc unregistered [ 8921.388309] LNet: 199197:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8921.405725] LNetError: 199197:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8921.430672] LNet: Removed LNI 192.168.203.4@tcp [ 8922.166979] Key type .llcrypt unregistered [ 8922.169342] Key type ._llcrypt unregistered [ 8936.874622] Key type ._llcrypt registered [ 8936.878578] Key type .llcrypt registered [ 8938.424089] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 02:50:40 (1788591040) [ 8975.872289] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8975.906083] alg: No test for adler32 (adler32-zlib) [ 8976.867395] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 8977.102570] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 8978.767679] Key type lgssc registered [ 8979.784179] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9023.971279] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9029.445679] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9064.856381] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9090.885553] Key type lgssc unregistered [ 9091.141734] LNet: 202928:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9091.151923] LNetError: 202928:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9091.181333] LNet: Removed LNI 192.168.203.4@tcp [ 9091.868755] Key type .llcrypt unregistered [ 9091.871500] Key type ._llcrypt unregistered [ 9107.504080] Key type ._llcrypt registered [ 9107.506356] Key type .llcrypt registered [ 9108.737268] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 02:53:30 (1788591210) [ 9111.200183] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9111.226901] alg: No test for adler32 (adler32-zlib) [ 9112.217696] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 9112.534059] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 9114.231245] Key type lgssc registered [ 9115.315985] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9162.876619] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9168.803736] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9188.393703] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9189.918911] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 9200.107573] Lustre: lustre-MDT0000-mdc-ffff894c055e1000: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9205.224565] Lustre: lustre-MDT0001-mdc-ffff894c055e1000: Connection to lustre-MDT0001 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9221.599352] Lustre: 203918:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788591308/real 1788591308] req@00000000bb0db310 x1875473821941760/t0(0) o400->MGC192.168.203.104@tcp@192.168.203.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1788591324 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9221.632957] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [ 9230.896084] Lustre: Evicted from MGS (at 192.168.203.104@tcp) after server handle changed from 0xa72f4fd023a55560 to 0xa72f4fd023a5726a [ 9230.911734] Lustre: MGC192.168.203.104@tcp: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 9251.320802] LustreError: lustre-MDT0000-mdc-ffff894c055e1000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9251.337635] Lustre: lustre-MDT0000-mdc-ffff894c055e1000: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 9253.658822] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9255.038504] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9260.041892] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9261.633717] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9263.715588] Lustre: Unmounted lustre-client [ 9289.691279] Key type lgssc unregistered [ 9289.932291] LNet: 207873:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9289.945532] LNetError: 207873:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9289.974843] LNet: Removed LNI 192.168.203.4@tcp [ 9290.643680] Key type .llcrypt unregistered [ 9290.647324] Key type ._llcrypt unregistered [ 9305.131600] Key type ._llcrypt registered [ 9305.134743] Key type .llcrypt registered [ 9306.351793] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 02:56:48 (1788591408) [ 9308.377662] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9308.569467] alg: No test for adler32 (adler32-zlib) [ 9309.601878] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 9309.830139] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 9311.535144] Key type lgssc registered [ 9312.577502] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9358.555171] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9364.768299] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9421.664373] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9426.493249] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9457.662576] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9478.671893] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9514.849770] Key type lgssc unregistered [ 9515.109270] LNet: 213161:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9515.125148] LNetError: 213161:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9515.161289] LNet: Removed LNI 192.168.203.4@tcp [ 9515.854954] Key type .llcrypt unregistered [ 9515.858226] Key type ._llcrypt unregistered [ 9557.071912] Key type ._llcrypt registered [ 9557.076987] Key type .llcrypt registered [ 9558.858614] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 03:01:00 (1788591660) [ 9595.518163] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9595.538227] alg: No test for adler32 (adler32-zlib) [ 9596.544477] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [ 9596.814060] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [ 9598.495191] Key type lgssc registered [ 9599.755891] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9666.707272] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9672.289550] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9698.115922] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9740.499673] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 03:04:02 (1788591842) [ 9748.089241] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 03:04:10 (1788591850) [ 9782.397203] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9788.070042] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9806.945179] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9809.594041] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 9815.040303] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9816.801266] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9818.180923] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9819.624358] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9825.268133] Lustre: lustre-MDT0000-mdc-ffff894c09b05800: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9840.619078] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [ 9840.650161] Lustre: Evicted from MGS (at 192.168.203.104@tcp) after server handle changed from 0x6b874abb591cc8a5 to 0x6b874abb591ccb14 [ 9840.674393] Lustre: MGC192.168.203.104@tcp: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 9845.173818] Lustre: lustre-MDT0000-mdc-ffff894c09b05800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 9853.938143] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9855.677464] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9859.974791] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9866.231869] Lustre: lustre-MDT0000-mdc-ffff894c09b05800: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9882.594085] Lustre: 215063:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788591969/real 1788591969] req@000000008de18147 x1875474330437120/t0(0) o400->MGC192.168.203.104@tcp@192.168.203.104@tcp:26/25 lens 224/224 e 0 to 1 dl 1788591985 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9882.651093] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [ 9882.697323] Lustre: Evicted from MGS (at 192.168.203.104@tcp) after server handle changed from 0x6b874abb591ccb14 to 0x6b874abb591ccd28 [ 9882.715339] Lustre: MGC192.168.203.104@tcp: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 9897.430537] Lustre: lustre-MDT0000-mdc-ffff894c09b05800: Connection restored to 192.168.203.104@tcp (at 192.168.203.104@tcp) [ 9904.316232] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9905.773130] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9909.060558] Lustre: Unmounted lustre-client [ 9968.223695] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9972.512276] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9989.939904] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9996.334090] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [ 9998.290129] Lustre: Unmounted lustre-client [10024.626834] Key type lgssc unregistered [10024.881211] LNet: 225642:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10024.896467] LNetError: 225642:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10024.913952] LNet: Removed LNI 192.168.203.4@tcp [10025.643393] Key type .llcrypt unregistered [10025.645160] Key type ._llcrypt unregistered [10041.307558] Key type ._llcrypt registered [10041.309913] Key type .llcrypt registered [10042.781487] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 03:09:04 (1788592144) [10046.376170] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10046.488836] alg: No test for adler32 (adler32-zlib) [10047.585450] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [10047.827914] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [10049.480644] Key type lgssc registered [10050.790865] Lustre: Echo OBD driver; http://www.lustre.org/ [10099.407344] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10105.029554] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10128.541515] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10131.412077] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [10138.816838] Lustre: Unmounted lustre-client [10202.024591] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10207.067773] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10226.256684] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10227.029780] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [10235.451805] Lustre: Unmounted lustre-client [10297.820159] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10302.770441] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10321.769623] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10322.211128] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [10324.170727] Lustre: Unmounted lustre-client [10348.891350] Key type lgssc unregistered [10349.149937] LNet: 232681:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10349.161103] LNetError: 232681:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10349.180595] LNet: Removed LNI 192.168.203.4@tcp [10349.910844] Key type .llcrypt unregistered [10349.914627] Key type ._llcrypt unregistered [10363.274813] Key type ._llcrypt registered [10363.278966] Key type .llcrypt registered [10364.737801] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 03:14:26 (1788592466) [10367.662223] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10367.696063] alg: No test for adler32 (adler32-zlib) [10368.901357] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [10369.245960] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [10370.935239] Key type lgssc registered [10372.570781] Lustre: Echo OBD driver; http://www.lustre.org/ [10412.358311] Key type lgssc unregistered [10412.601722] LNet: 234998:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10412.607962] LNetError: 234998:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10412.632962] LNet: Removed LNI 192.168.203.4@tcp [10413.340864] Key type .llcrypt unregistered [10413.343229] Key type ._llcrypt unregistered [10439.946597] Key type ._llcrypt registered [10439.955147] Key type .llcrypt registered [10440.492839] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10440.511549] alg: No test for adler32 (adler32-zlib) [10441.604120] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [10441.857320] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [10443.591163] Key type lgssc registered [10444.774524] Lustre: Echo OBD driver; http://www.lustre.org/ [10515.539235] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10520.661985] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10541.077946] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10577.589918] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10579.547676] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 03:18:01 (1788592681) [10609.106846] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10614.090820] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10633.760860] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10651.724933] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10653.191470] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [10658.281906] Lustre: lustre-OST0001-osc-ffff894c20341800: Connection to lustre-OST0001 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [10664.088535] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10674.419355] Lustre: Unmounted lustre-client [10704.031497] Key type lgssc unregistered [10704.249835] LNet: 242096:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10704.257523] LNetError: 242096:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10705.319695] LNet: Removed LNI 192.168.203.4@tcp [10705.871197] Key type .llcrypt unregistered [10705.874519] Key type ._llcrypt unregistered [10728.209888] Key type ._llcrypt registered [10728.212871] Key type .llcrypt registered [10729.178794] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 03:20:31 (1788592831) [10740.231385] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10740.304093] alg: No test for adler32 (adler32-zlib) [10741.333680] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [10741.575136] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [10743.231182] Key type lgssc registered [10744.176333] Lustre: Echo OBD driver; http://www.lustre.org/ [10787.144654] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10792.397600] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10813.616355] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 03:21:55 (1788592915) [10851.090527] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10857.176748] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10878.933568] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10880.788081] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [10892.281700] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [10900.624103] Lustre: Unmounted lustre-client [11001.446753] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11007.067392] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11059.594077] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11060.338640] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [11063.179207] Lustre: Unmounted lustre-client [11089.623179] Key type lgssc unregistered [11089.857154] LNet: 249799:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11089.866017] LNetError: 249799:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11089.879992] LNet: Removed LNI 192.168.203.4@tcp [11090.519213] Key type .llcrypt unregistered [11090.521880] Key type ._llcrypt unregistered [11118.370913] Key type ._llcrypt registered [11118.378300] Key type .llcrypt registered [11118.865253] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11118.911290] alg: No test for adler32 (adler32-zlib) [11120.008844] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [11120.246839] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [11121.911186] Key type lgssc registered [11122.994417] Lustre: Echo OBD driver; http://www.lustre.org/ [11196.314364] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11202.044792] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11223.796743] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11271.369557] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11272.791759] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 03:29:34 (1788593374) [11301.531712] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11306.477317] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11324.943868] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11329.078366] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [11332.234991] Lustre: Unmounted lustre-client [11358.720174] Key type lgssc unregistered [11359.013822] LNet: 256422:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11359.026258] LNetError: 256422:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11359.071997] LNet: Removed LNI 192.168.203.4@tcp [11359.803201] Key type .llcrypt unregistered [11359.806710] Key type ._llcrypt unregistered [11377.946961] Key type ._llcrypt registered [11377.952735] Key type .llcrypt registered [11379.879163] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11382.004210] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 03:31:23 (1788593483) [11394.090895] Key type .llcrypt unregistered [11394.096306] Key type ._llcrypt unregistered [11404.007861] Key type ._llcrypt registered [11404.020360] Key type .llcrypt registered [11404.464986] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11404.473533] alg: No test for adler32 (adler32-zlib) [11405.621396] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [11405.971668] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [11407.647623] Key type lgssc registered [11409.117770] Lustre: Echo OBD driver; http://www.lustre.org/ [11457.144887] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11474.576875] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [11477.487502] Lustre: Unmounted lustre-client [11504.371602] Key type lgssc unregistered [11504.591227] LNet: 259872:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11504.604553] LNetError: 259872:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11504.624548] LNet: Removed LNI 192.168.203.4@tcp [11505.336165] Key type .llcrypt unregistered [11505.339023] Key type ._llcrypt unregistered [11520.440618] Key type ._llcrypt registered [11520.442723] Key type .llcrypt registered [11521.889764] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 03:33:43 (1788593623) [11524.317526] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11524.341957] alg: No test for adler32 (adler32-zlib) [11525.426483] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [11525.719196] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [11527.431839] Key type lgssc registered [11528.619489] Lustre: Echo OBD driver; http://www.lustre.org/ [11610.547235] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11644.866857] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11651.075821] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11653.933956] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [11656.903238] Lustre: Unmounted lustre-client [11681.192895] Key type lgssc unregistered [11681.485497] LNet: 263406:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11681.495476] LNetError: 263406:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11681.513897] LNet: Removed LNI 192.168.203.4@tcp [11682.206917] Key type .llcrypt unregistered [11682.210881] Key type ._llcrypt unregistered [11697.589285] Key type ._llcrypt registered [11697.593424] Key type .llcrypt registered [11699.278474] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 03:36:40 (1788593800) [11701.670666] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11701.792533] alg: No test for adler32 (adler32-zlib) [11702.961602] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [11703.249587] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [11704.927256] Key type lgssc registered [11706.223976] Lustre: Echo OBD driver; http://www.lustre.org/ [11755.845391] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11762.506428] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11785.742395] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11788.461994] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [11793.915638] Lustre: lustre-MDT0000-mdc-ffff894c18799000: Connection to lustre-MDT0000 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [11795.119702] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11795.153174] LustreError: 266560:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [11795.614489] LustreError: MGC192.168.203.104@tcp: Connection to MGS (at 192.168.203.104@tcp) was lost; in progress operations using this service will fail [11795.669863] Lustre: Unmounted lustre-client [11817.993755] Key type lgssc unregistered [11818.383140] LNet: 266973:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11818.389900] LNetError: 266973:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11818.415941] LNet: Removed LNI 192.168.203.4@tcp [11819.203947] Key type .llcrypt unregistered [11819.212905] Key type ._llcrypt unregistered [11836.431751] Key type ._llcrypt registered [11836.433930] Key type .llcrypt registered [11838.076645] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 03:38:59 (1788593939) [11840.933039] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11840.981360] alg: No test for adler32 (adler32-zlib) [11842.110692] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [11842.427170] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [11844.255193] Key type lgssc registered [11845.716926] Lustre: Echo OBD driver; http://www.lustre.org/ [11897.663684] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11902.939547] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11924.503157] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11927.237209] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [11932.649410] Lustre: lustre-MDT0001-mdc-ffff894c04aca000: Connection to lustre-MDT0001 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [11937.987135] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [11940.851388] Lustre: Unmounted lustre-client [11960.819712] Key type lgssc unregistered [11961.117656] LNet: 270547:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11961.125066] LNetError: 270547:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11961.147053] LNet: Removed LNI 192.168.203.4@tcp [11961.909869] Key type .llcrypt unregistered [11961.911667] Key type ._llcrypt unregistered [11977.234397] Key type ._llcrypt registered [11977.236690] Key type .llcrypt registered [11978.524908] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 03:41:20 (1788594080) [11998.380745] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11998.434376] alg: No test for adler32 (adler32-zlib) [11999.562482] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [11999.965231] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [12001.767278] Key type lgssc registered [12003.116528] Lustre: Echo OBD driver; http://www.lustre.org/ [12111.096485] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12113.763740] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [12155.366481] Lustre: lustre-MDT0001-mdc-ffff894c06ad3000: Connection to lustre-MDT0001 (at 192.168.203.104@tcp) was lost; in progress operations using this service will wait for recovery to complete [12165.201777] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12175.553448] Lustre: Unmounted lustre-client [12204.461846] Key type lgssc unregistered [12204.779807] LNet: 276326:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12204.790866] LNetError: 276326:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12205.868256] LNet: Removed LNI 192.168.203.4@tcp [12206.753301] Key type .llcrypt unregistered [12206.757180] Key type ._llcrypt unregistered [12226.040479] Key type ._llcrypt registered [12226.041788] Key type .llcrypt registered [12227.351305] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 03:45:29 (1788594329) [12229.273990] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12231.033735] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 03:45:32 (1788594332) [12232.700077] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12234.612044] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 03:45:36 (1788594336) [12236.301777] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12238.139297] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 03:45:39 (1788594339) [12239.987829] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12242.544300] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 03:45:43 (1788594343) [12244.040140] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12245.975734] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 03:45:47 (1788594347) [12255.630802] Key type .llcrypt unregistered [12255.632653] Key type ._llcrypt unregistered [12263.790982] Key type ._llcrypt registered [12263.798053] Key type .llcrypt registered [12264.284776] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12264.295838] alg: No test for adler32 (adler32-zlib) [12265.354471] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [12265.625494] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [12267.272085] Key type lgssc registered [12268.685275] Lustre: Echo OBD driver; http://www.lustre.org/ [12346.464286] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12352.038271] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12374.726195] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12376.313253] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [12378.952814] Lustre: Unmounted lustre-client [12416.042902] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 03:48:37 (1788594517) [12450.982252] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12457.039842] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12491.097145] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12496.969835] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [12499.681427] Lustre: Unmounted lustre-client [12542.112701] LNet: 1 local NIs in recovery (showing 1): 192.168.203.4@tcp [12542.238283] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 03:50:44 (1788594644) [13188.289598] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13192.569438] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13224.011953] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13315.922673] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 04:03:38 (1788595418) [13328.531190] Key type lgssc unregistered [13328.831803] LNet: 289878:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13328.837907] LNetError: 289878:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13328.863261] LNet: Removed LNI 192.168.203.4@tcp [13329.502705] Key type .llcrypt unregistered [13329.508456] Key type ._llcrypt unregistered [13468.812354] Key type ._llcrypt registered [13468.816072] Key type .llcrypt registered [13469.109181] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13469.131111] alg: No test for adler32 (adler32-zlib) [13470.267037] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [13470.562915] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13472.223219] Key type lgssc registered [13473.330800] Lustre: Echo OBD driver; http://www.lustre.org/ [13557.648671] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13563.680287] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13585.435667] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13626.827515] Key type lgssc unregistered [13627.162486] LNet: 293579:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13627.175384] LNetError: 293579:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13627.202248] LNet: Removed LNI 192.168.203.4@tcp [13628.105768] Key type .llcrypt unregistered [13628.115377] Key type ._llcrypt unregistered [13665.605580] Key type ._llcrypt registered [13665.607946] Key type .llcrypt registered [13666.899271] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 04:09:28 (1788595768) [13685.476910] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13685.520495] alg: No test for adler32 (adler32-zlib) [13686.669595] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [13686.917744] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13688.663229] Key type lgssc registered [13689.651526] Lustre: Echo OBD driver; http://www.lustre.org/ [13739.857815] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 04:10:41 (1788595841) [13752.132780] Key type lgssc unregistered [13752.425108] LNet: 297132:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13752.439263] LNetError: 297132:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13752.470434] LNet: Removed LNI 192.168.203.4@tcp [13753.263890] Key type .llcrypt unregistered [13753.265732] Key type ._llcrypt unregistered [13765.217357] Key type ._llcrypt registered [13765.219050] Key type .llcrypt registered [13765.628913] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13765.653693] alg: No test for adler32 (adler32-zlib) [13766.707466] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [13766.931925] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [13768.583677] Key type lgssc registered [13769.846689] Lustre: Echo OBD driver; http://www.lustre.org/ [13823.732560] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13828.591200] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13850.436372] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14116.744901] LNet: Added LNI 192.168.203.4@tcp50 [8/256/0/180] [14119.072328] LNet: Removed LNI 192.168.203.4@tcp [14121.134933] Lustre: 301537:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff894c065e5800: config has no valid NIDs, force dynamic NIDs [14122.324411] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [14122.472633] Lustre: Unmounted lustre-client [14124.881859] Key type lgssc unregistered [14125.248629] LNet: 301794:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14125.252809] LNetError: 301794:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14125.269778] LNet: Removed LNI 192.168.203.4@tcp50 [14126.030525] Key type .llcrypt unregistered [14126.033167] Key type ._llcrypt unregistered [14143.870437] Key type ._llcrypt registered [14143.875890] Key type .llcrypt registered [14144.492927] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14144.537353] alg: No test for adler32 (adler32-zlib) [14145.643915] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [14145.887355] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [14147.671192] Key type lgssc registered [14148.748993] Lustre: Echo OBD driver; http://www.lustre.org/ [14210.851515] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14217.636565] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14226.211181] LNet: Added LNI 192.168.203.4@tcp50 [8/256/0/180] [14227.261785] LNet: Removed LNI 192.168.203.4@tcp [14228.582995] Lustre: 304499:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff894c08f91800: config has no valid NIDs, force dynamic NIDs [14229.808436] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [14230.476466] Lustre: Unmounted lustre-client [14262.773981] Key type lgssc unregistered [14263.104996] LNet: 305365:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14263.112112] LNetError: 305365:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14263.132961] LNet: Removed LNI 192.168.203.4@tcp50 [14263.656335] Key type .llcrypt unregistered [14263.668821] Key type ._llcrypt unregistered [14274.547898] Key type ._llcrypt registered [14274.551597] Key type .llcrypt registered [14276.320757] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 04:19:37 (1788596377) [14294.414392] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14294.470702] alg: No test for adler32 (adler32-zlib) [14295.622163] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [14295.879987] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [14297.591183] Key type lgssc registered [14298.927410] Lustre: Echo OBD driver; http://www.lustre.org/ [14377.106957] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14381.563842] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14401.404266] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14441.147788] Key type lgssc unregistered [14441.395590] LNet: 310111:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14441.407782] LNetError: 310111:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14441.432120] LNet: Removed LNI 192.168.203.4@tcp [14442.175784] Key type .llcrypt unregistered [14442.178443] Key type ._llcrypt unregistered [14453.453150] Key type ._llcrypt registered [14453.456969] Key type .llcrypt registered [14454.842352] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 04:22:36 (1788596556) [14456.856434] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14456.898164] alg: No test for adler32 (adler32-zlib) [14457.966329] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [14458.199828] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [14459.855230] Key type lgssc registered [14461.083727] Lustre: Echo OBD driver; http://www.lustre.org/ [14506.232438] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14511.505829] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14531.238608] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14532.950567] Lustre: Mounted lustre-client - version 2.17.57_104_g4a8f637 [14586.023183] Lustre: Mounted fs15246-client - version 2.17.57_104_g4a8f637 [14599.252861] Lustre: Unmounted fs15246-client [14625.056636] Lustre: Unmounted lustre-client [14654.495013] Key type lgssc unregistered [14654.830700] LNet: 314970:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14654.840355] LNetError: 314970:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14654.869399] LNet: Removed LNI 192.168.203.4@tcp [14655.619757] Key type .llcrypt unregistered [14655.622223] Key type ._llcrypt unregistered [14667.521260] Key type ._llcrypt registered [14667.525654] Key type .llcrypt registered [14668.800610] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 04:26:10 (1788596770) [14671.039172] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14671.046649] alg: No test for adler32 (adler32-zlib) [14672.243873] Lustre: Lustre: Build Version: 2.17.57_104_g4a8f637 [14672.548815] LNet: Added LNI 192.168.203.4@tcp [8/256/0/180] [14674.247199] Key type lgssc registered [14675.235292] Lustre: Echo OBD driver; http://www.lustre.org/ [14803.260151] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14808.151504] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14827.635979] Lustre: DEBUG MARKER: oleg304-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14932.352395] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 14672 sec ========= 04:30:34 (1788597034) [14933.913468] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 04:30:35 (1788597035) === [14936.847519] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 04:30:38 (1788597038) === [14970.142255] Key type lgssc unregistered [14970.462870] LNet: 324226:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14970.473082] LNetError: 324226:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14970.505282] LNet: Removed LNI 192.168.203.4@tcp [14971.324631] Key type .llcrypt unregistered [14971.326573] Key type ._llcrypt unregistered