[ 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 456357059 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: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003229] x2apic enabled [ 0.004013] Switched APIC routing to physical x2apic. [ 0.005017] kvm-guest: setup PV IPIs [ 0.008644] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009022] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010015] pid_max: default: 32768 minimum: 301 [ 0.011153] LSM: Security Framework initializing [ 0.012071] Yama: becoming mindful. [ 0.013037] SELinux: Initializing. [ 0.015069] *** VALIDATE selinux *** [ 0.023114] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027808] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.029120] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030113] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031132] *** VALIDATE tmpfs *** [ 0.033432] *** VALIDATE proc *** [ 0.034273] *** VALIDATE cgroup *** [ 0.036007] *** VALIDATE cgroup2 *** [ 0.037303] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.039155] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.040010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.041039] Spectre V2 : User space: Vulnerable [ 0.042009] Speculative Store Bypass: Vulnerable [ 0.045659] debug: unmapping init [mem 0xffffffffb7659000-0xffffffffb7660fff] [ 0.047788] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.048702] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.049027] ... version: 2 [ 0.050014] ... bit width: 48 [ 0.051013] ... generic registers: 4 [ 0.052011] ... value mask: 0000ffffffffffff [ 0.053017] ... max period: 00007fffffffffff [ 0.054016] ... fixed-purpose events: 3 [ 0.055010] ... event mask: 000000070000000f [ 0.056285] rcu: Hierarchical SRCU implementation. [ 0.058377] smp: Bringing up secondary CPUs ... [ 0.059592] x86: Booting SMP configuration: [ 0.060026] .... node #0, CPUs: #1 #2 #3 [ 0.063289] smp: Brought up 1 node, 4 CPUs [ 0.065013] smpboot: Max logical packages: 1 [ 0.066021] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.143042] node 0 deferred pages initialised in 74ms [ 0.146009] devtmpfs: initialized [ 0.147280] x86/mm: Memory block size: 128MB [ 0.149900] gcov: version magic: 0x41383552 [ 0.152277] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.153086] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.155338] pinctrl core: initialized pinctrl subsystem [ 0.158155] [ 0.158667] ************************************************************* [ 0.161037] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.163011] ** ** [ 0.166013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.167012] ** ** [ 0.170013] ** This means that this kernel is built to expose internal ** [ 0.172014] ** IOMMU data structures, which may compromise security on ** [ 0.174013] ** your system. ** [ 0.176014] ** ** [ 0.178010] ** If you see this message and you are not debugging the ** [ 0.181013] ** kernel, report this immediately to your vendor! ** [ 0.183010] ** ** [ 0.185016] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.188011] ************************************************************* [ 0.190638] NET: Registered protocol family 16 [ 0.192447] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.194130] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.197064] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.201013] cpuidle: using governor menu [ 0.202461] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.204611] PCI: Using configuration type 1 for base access [ 0.206131] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.213110] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.214029] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.216104] cryptd: max_cpu_qlen set to 1000 [ 0.219216] ACPI: Added _OSI(Module Device) [ 0.221016] ACPI: Added _OSI(Processor Device) [ 0.222010] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.224013] ACPI: Added _OSI(Processor Aggregator Device) [ 0.229170] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.235536] ACPI: Interpreter enabled [ 0.237078] ACPI: PM: (supports S0 S3 S4 S5) [ 0.238009] ACPI: Using IOAPIC for interrupt routing [ 0.239086] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.241406] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.251859] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.254056] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.256021] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.260106] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.264342] acpiphp: Slot [2] registered [ 0.266115] acpiphp: Slot [5] registered [ 0.267122] acpiphp: Slot [6] registered [ 0.269122] acpiphp: Slot [3] registered [ 0.270127] acpiphp: Slot [4] registered [ 0.271088] acpiphp: Slot [7] registered [ 0.273089] acpiphp: Slot [8] registered [ 0.274101] acpiphp: Slot [9] registered [ 0.276102] acpiphp: Slot [10] registered [ 0.277133] acpiphp: Slot [11] registered [ 0.279088] acpiphp: Slot [12] registered [ 0.280122] acpiphp: Slot [13] registered [ 0.282181] acpiphp: Slot [14] registered [ 0.283116] acpiphp: Slot [15] registered [ 0.285116] acpiphp: Slot [16] registered [ 0.286074] acpiphp: Slot [17] registered [ 0.288102] acpiphp: Slot [18] registered [ 0.289118] acpiphp: Slot [19] registered [ 0.291125] acpiphp: Slot [20] registered [ 0.292094] acpiphp: Slot [21] registered [ 0.294108] acpiphp: Slot [22] registered [ 0.295092] acpiphp: Slot [23] registered [ 0.297083] acpiphp: Slot [24] registered [ 0.298092] acpiphp: Slot [25] registered [ 0.300095] acpiphp: Slot [26] registered [ 0.302119] acpiphp: Slot [27] registered [ 0.303104] acpiphp: Slot [28] registered [ 0.305084] acpiphp: Slot [29] registered [ 0.306089] acpiphp: Slot [30] registered [ 0.308100] acpiphp: Slot [31] registered [ 0.309046] PCI host bridge to bus 0000:00 [ 0.311021] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.313024] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.315025] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.318026] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.321023] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.323023] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.325177] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.329144] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.331238] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.339018] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.343057] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.346014] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.348020] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.350018] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.353544] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.357909] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.360046] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.362830] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.366962] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.376647] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.381014] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.386354] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.394016] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.401020] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.423015] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.436872] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.446020] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.452018] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.474016] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.496788] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.498388] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.501413] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.503357] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.506201] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.511125] iommu: Default domain type: Passthrough [ 0.512331] SCSI subsystem initialized [ 0.513087] ACPI: bus type USB registered [ 0.514028] usbcore: registered new interface driver usbfs [ 0.515076] usbcore: registered new interface driver hub [ 0.518090] usbcore: registered new device driver usb [ 0.520159] pps_core: LinuxPPS API ver. 1 registered [ 0.521006] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.523056] PTP clock support registered [ 0.524121] EDAC MC: Ver: 3.0.0 [ 0.525801] PCI: Using ACPI for IRQ routing [ 0.526916] NetLabel: Initializing [ 0.527010] NetLabel: domain hash size = 128 [ 0.528012] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.529103] NetLabel: unlabeled traffic allowed by default [ 0.531036] vgaarb: loaded [ 0.532252] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.533012] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.544956] clocksource: Switched to clocksource kvm-clock [ 0.651124] VFS: Disk quotas dquot_6.6.0 [ 0.652240] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.654057] *** VALIDATE ramfs *** [ 0.654830] *** VALIDATE hugetlbfs *** [ 0.655781] pnp: PnP ACPI init [ 0.657306] pnp: PnP ACPI: found 6 devices [ 0.674073] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.677141] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.679333] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.681450] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.683733] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.686234] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.688812] NET: Registered protocol family 2 [ 0.691288] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.695944] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.699491] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.703758] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.707110] TCP: Hash tables configured (established 65536 bind 65536) [ 0.709945] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.713177] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.715792] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.718961] NET: Registered protocol family 1 [ 0.721140] RPC: Registered named UNIX socket transport module. [ 0.723352] RPC: Registered udp transport module. [ 0.724576] RPC: Registered tcp transport module. [ 0.725647] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.727477] NET: Registered protocol family 44 [ 0.728760] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.730114] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.732155] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.734284] PCI: CLS 0 bytes, default 64 [ 0.735898] Unpacking initramfs... [ 2.126703] debug: unmapping init [mem 0xffff8dbebcc64000-0xffff8dbebffcffff] [ 2.130673] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.132993] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.135818] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.606685] Initialise system trusted keyrings [ 2.608196] Key type blacklist registered [ 2.609599] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.618328] zbud: loaded [ 2.621163] *** VALIDATE nfs *** [ 2.622200] *** VALIDATE nfs4 *** [ 2.623442] pstore: using deflate compression [ 2.626674] Platform Keyring initialized [ 2.726108] NET: Registered protocol family 38 [ 2.727642] Key type asymmetric registered [ 2.729489] Asymmetric key parser 'x509' registered [ 2.731401] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.734705] io scheduler mq-deadline registered [ 2.736525] io scheduler kyber registered [ 2.738345] io scheduler bfq registered [ 2.740367] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.742966] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.745655] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.747914] ACPI: Power Button [PWRF] [ 2.753105] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.759172] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.868531] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.897150] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.924113] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.927984] Non-volatile memory driver v1.3 [ 2.929298] Linux agpgart interface v0.103 [ 2.951642] virtio_blk virtio1: [vda] 145912 512-byte logical blocks (74.7 MB/71.2 MiB) [ 2.953274] vda: detected capacity change from 0 to 74706944 [ 2.968531] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.971144] vdb: detected capacity change from 0 to 1073741824 [ 2.976551] libphy: Fixed MDIO Bus: probed [ 2.988117] usbcore: registered new interface driver usbserial_generic [ 2.990121] usbserial: USB Serial support registered for generic [ 2.992263] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.996848] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.998691] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.001196] mousedev: PS/2 mouse device common for all mice [ 3.004116] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.007658] rtc_cmos 00:05: RTC can wake from S4 [ 3.010788] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.013906] rtc_cmos 00:05: registered as rtc0 [ 3.016964] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.019642] intel_pstate: CPU model not supported [ 3.021693] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.024821] hid: raw HID events driver (C) Jiri Kosina [ 3.026960] usbcore: registered new interface driver usbhid [ 3.029241] usbhid: USB HID core driver [ 3.030834] drop_monitor: Initializing network drop monitor service [ 3.033328] Initializing XFRM netlink socket [ 3.035473] NET: Registered protocol family 10 [ 3.040141] Segment Routing with IPv6 [ 3.041600] NET: Registered protocol family 17 [ 3.043813] mpls_gso: MPLS GSO support [ 3.049392] RAS: Correctable Errors collector initialized. [ 3.051180] AVX version of gcm_enc/dec engaged. [ 3.052706] AES CTR mode by8 optimization enabled [ 3.127860] sched_clock: Marking stable (3127833241, 0)->(4047837096, -920003855) [ 3.131590] registered taskstats version 1 [ 3.133432] Loading compiled-in X.509 certificates [ 3.135455] zswap: loaded using pool lzo/zbud [ 3.160435] Key type big_key registered [ 3.171261] Key type encrypted registered [ 3.172949] ima: No TPM chip found, activating TPM-bypass! [ 3.174860] ima: Allocated hash algorithm: sha1 [ 3.176822] ima: No architecture policies found [ 3.178635] evm: Initialising EVM extended attributes: [ 3.180764] evm: security.selinux [ 3.182233] evm: security.ima [ 3.183389] evm: security.capability [ 3.184821] evm: HMAC attrs: 0x1 [ 3.187167] rtc_cmos 00:05: setting system clock to 2026-08-18 17:49:32 UTC (1787075372) [ 3.193828] debug: unmapping init [mem 0xffffffffb8603000-0xffffffffb87fffff] [ 3.196895] debug: unmapping init [mem 0xffffffffb7382000-0xffffffffb7658fff] [ 3.204188] Write protecting the kernel read-only data: 28672k [ 3.206400] debug: unmapping init [mem 0xffffffffb5a03000-0xffffffffb5bfffff] [ 3.209292] debug: unmapping init [mem 0xffffffffb6314000-0xffffffffb63fffff] [ 3.243747] 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.252039] systemd[1]: Detected virtualization kvm. [ 3.253830] systemd[1]: Detected architecture x86-64. [ 3.255861] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.278910] systemd[1]: No hostname configured. [ 3.280054] systemd[1]: Set hostname to . [ 3.281341] random: systemd: uninitialized urandom read (16 bytes read) [ 3.283049] systemd[1]: Initializing machine ID from random generator. [ 3.319802] random: ln: uninitialized urandom read (6 bytes read) [ 3.393691] random: systemd: uninitialized urandom read (16 bytes read) [ 3.396168] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 3.400524] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.406694] systemd[1]: Starting Apply Kernel Variables... Starting Apply Kernel Variables... [ OK ] Started Memstrack Anylazing Service. Starting Setup Virtual Console... [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Swap. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Timers. [ OK ] Reached target Slices. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev.[ 3.554809] random: fast init done [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.924890] device-mapper: uevent: version 1.0.3 [ 3.927111] 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. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.558574] virtio_net virtio0 ens2: renamed from eth0 [ 4.600900] scsi host0: ata_piix [ 4.639586] scsi host1: ata_piix [ 4.641256] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.643594] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.138620] dracut-initqueue[592]: RTNETLINK answers: File exists [ 9.690656] random: crng init done [ 9.692244] 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.094267] 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 Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.226434] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.483056] SELinux: Disabled at runtime. [ 11.542648] 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.551924] systemd[1]: Detected virtualization kvm. [ 11.553809] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.026899] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.030314] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.036393] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.041261] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.045475] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.054737] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.060093] systemd[1]: Reached target rpc_pipefs.target. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice User and Session Slice. [ OK ] Listening on udev Kernel Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Control Socket. [ OK ] Created slice system-sshd\x2dkeygen.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 Process Core Dump Socket. Starting Remount Root and Kernel File Systems... Starting udev Coldplug all Devices... [ OK ] Reached target Slices. Activating swap /dev/disk/by-label/SWAP... [ OK ] Started Forward Password Requests to Wall Directory Watch. Mounting Kernel Debug File System... Mounting POSIX Message Queue File System... [ 12.163770] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on initctl Compatibility Named Pipe. Mounting Huge Pages File System... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [ OK ] Created slice system-getty.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-serial\x2dgetty.slice. Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.477737] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.805183] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.840304] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.926322] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.936593] EDAC sbridge: Ver: 1.1.2 [ 14.037550] Key type dns_resolver registered [ 14.338150] NFS: Registering the id_resolver key type [ 14.340042] Key type id_resolver registered [ 14.341044] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Basic System. Starting Login Service... [ OK ] Started D-Bus System Message Bus. [ OK ] Started irqbalance daemon. Starting Network Manager... Starting Restore /run/initramfs on shutdown... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. 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 oleg224-client login: [ 50.095517] libcfs: loading out-of-tree module taints kernel. [ 50.185824] Key type ._llcrypt registered [ 50.194571] Key type .llcrypt registered [ 51.172213] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 51.198272] alg: No test for adler32 (adler32-zlib) [ 52.886137] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 54.241968] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 56.161846] Key type lgssc registered [ 58.185566] Lustre: Echo OBD driver; http://www.lustre.org/ [ 62.630087] hrtimer: interrupt took 3138116 ns [ 238.342229] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 243.446736] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 257.070885] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing check_logdir /tmp/testlogs/ [ 262.878813] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing yml_node [ 264.160921] Lustre: lustre-OST0000-osc-ffff8dbf05714000: disconnect after 23s idle [ 266.436282] Lustre: DEBUG MARKER: Client: 2.17.57.1 [ 268.998825] Lustre: DEBUG MARKER: MDS: 2.17.57.1 [ 271.941751] Lustre: DEBUG MARKER: OSS: 2.17.57.1 [ 273.935032] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Tue Aug 18 13:54:01 EDT 2026 [ 292.077851] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 293.863205] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 296.890871] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 307.288494] Lustre: Unmounted lustre-client [ 422.691536] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 428.404633] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 451.164992] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 490.154180] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 13:57:38 (1787075858) [ 492.586799] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 494.728794] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 13:57:42 (1787075862) [ 526.932390] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 532.549463] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 557.105916] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 558.029581] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 564.662540] Lustre: Unmounted lustre-client [ 593.232358] Key type lgssc unregistered [ 593.506990] LNet: 15030:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 593.514909] LNetError: 15030:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 593.538919] LNet: Removed LNI 192.168.202.24@tcp [ 594.467188] Key type .llcrypt unregistered [ 594.468627] Key type ._llcrypt unregistered [ 611.465105] Key type ._llcrypt registered [ 611.469123] Key type .llcrypt registered [ 612.565349] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 13:59:40 (1787075980) [ 614.301161] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 614.324836] alg: No test for adler32 (adler32-zlib) [ 615.514553] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 615.863291] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 617.544197] Key type lgssc registered [ 618.732149] Lustre: Echo OBD driver; http://www.lustre.org/ [ 700.872882] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 801.690069] Lustre: Unmounted lustre-client [ 840.549511] Key type lgssc unregistered [ 840.850969] LNet: 18887:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 840.857892] LNetError: 18887:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 840.885028] LNet: Removed LNI 192.168.202.24@tcp [ 841.752353] Key type .llcrypt unregistered [ 841.756176] Key type ._llcrypt unregistered [ 853.465571] Key type ._llcrypt registered [ 853.471139] Key type .llcrypt registered [ 855.208284] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 14:03:42 (1787076222) [ 858.007641] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 858.023257] alg: No test for adler32 (adler32-zlib) [ 859.117211] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 859.392545] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 861.088274] Key type lgssc registered [ 862.519898] Lustre: Echo OBD driver; http://www.lustre.org/ [ 920.728170] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 927.190161] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 951.216203] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 953.035064] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 967.695569] Lustre: Unmounted lustre-client [ 1005.685923] Key type lgssc unregistered [ 1006.114208] LNet: 22499:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1006.133374] LNetError: 22499:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1006.164744] LNet: Removed LNI 192.168.202.24@tcp [ 1007.191886] Key type .llcrypt unregistered [ 1007.195542] Key type ._llcrypt unregistered [ 1020.865567] Key type ._llcrypt registered [ 1020.868859] Key type .llcrypt registered [ 1022.352487] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 14:06:29 (1787076389) [ 1024.610969] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1024.650525] alg: No test for adler32 (adler32-zlib) [ 1025.798776] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 1026.076059] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 1027.784604] Key type lgssc registered [ 1029.173185] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1090.114439] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1096.050169] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1119.986434] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1132.132094] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 1139.447867] Lustre: Unmounted lustre-client [ 1178.101781] Key type lgssc unregistered [ 1178.401842] LNet: 25699:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1178.406435] LNetError: 25699:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1178.424757] LNet: Removed LNI 192.168.202.24@tcp [ 1179.280099] Key type .llcrypt unregistered [ 1179.285479] Key type ._llcrypt unregistered [ 1198.438484] Key type ._llcrypt registered [ 1198.444936] Key type .llcrypt registered [ 1199.937674] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 14:09:27 (1787076567) [ 1202.647942] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1202.668945] alg: No test for adler32 (adler32-zlib) [ 1203.844501] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 1204.106405] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 1205.768208] Key type lgssc registered [ 1206.921197] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1262.222608] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1267.197613] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1289.510954] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1292.365120] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 1302.521125] Lustre: lustre-MDT0000-mdc-ffff8dbf125c8800: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1312.757736] Lustre: lustre-MDT0001-mdc-ffff8dbf125c8800: Connection to lustre-MDT0001 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1319.432360] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1322.976171] Lustre: 26661:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787076676/real 1787076676] req@00000000ad0daf6e x1873885604616320/t0(0) o400->MGC192.168.202.124@tcp@192.168.202.124@tcp:26/25 lens 224/224 e 0 to 1 dl 1787076692 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1323.033755] LustreError: MGC192.168.202.124@tcp: Connection to MGS (at 192.168.202.124@tcp) was lost; in progress operations using this service will fail [ 1329.812586] Lustre: Unmounted lustre-client [ 1346.509474] Key type lgssc unregistered [ 1346.867574] LNet: 29360:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1346.874224] LNetError: 29360:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1346.913643] LNet: Removed LNI 192.168.202.24@tcp [ 1348.049885] Key type .llcrypt unregistered [ 1348.069206] Key type ._llcrypt unregistered [ 1368.204491] Key type ._llcrypt registered [ 1368.207054] Key type .llcrypt registered [ 1369.967360] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 14:12:17 (1787076737) [ 1373.112184] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1373.131669] alg: No test for adler32 (adler32-zlib) [ 1374.244817] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 1374.503885] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 1376.240271] Key type lgssc registered [ 1377.698827] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1433.687799] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1440.909081] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1466.033589] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1468.905314] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 1474.026368] Lustre: lustre-OST0000-osc-ffff8dbf05aa2800: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1481.414392] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1491.759506] Lustre: Unmounted lustre-client [ 1520.774286] Key type lgssc unregistered [ 1521.071185] LNet: 32976:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1521.079478] LNetError: 32976:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1522.151786] LNet: Removed LNI 192.168.202.24@tcp [ 1522.996294] Key type .llcrypt unregistered [ 1522.998431] Key type ._llcrypt unregistered [ 1540.625812] Key type ._llcrypt registered [ 1540.627937] Key type .llcrypt registered [ 1542.211485] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 14:15:09 (1787076909) [ 1545.382683] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1545.512468] alg: No test for adler32 (adler32-zlib) [ 1546.896986] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 1547.206195] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 1548.936326] Key type lgssc registered [ 1550.392688] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1607.821493] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1615.268407] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1637.636972] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1639.470472] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 1646.110569] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1650.144774] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1662.311494] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-1814h17m09s [ 1665.175295] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1670.121811] Lustre: lustre-MDT0000-mdc-ffff8dbf02985800: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1677.256627] LustreError: 36768:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8dbf02985800: can't stat MDS #0: rc = -19 [ 1679.081428] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1688.551870] LustreError: MGC192.168.202.124@tcp: Connection to MGS (at 192.168.202.124@tcp) was lost; in progress operations using this service will fail [ 1688.586932] Lustre: Evicted from MGS (at 192.168.202.124@tcp) after server handle changed from 0x9e60f150672c452d to 0x9e60f150672c47f7 [ 1688.604913] Lustre: MGC192.168.202.124@tcp: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 1689.648642] LustreError: lustre-MDT0000-mdc-ffff8dbf02985800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1689.711531] Lustre: lustre-MDT0000-mdc-ffff8dbf02985800: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 1696.979150] Lustre: DEBUG MARKER: Wait for df (36768) ... [ 1698.856587] Lustre: DEBUG MARKER: done [ 1700.897406] Lustre: Unmounted lustre-client [ 1729.986321] Key type lgssc unregistered [ 1730.267905] LNet: 37788:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1730.272966] LNetError: 37788:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1730.298751] LNet: Removed LNI 192.168.202.24@tcp [ 1731.073237] Key type .llcrypt unregistered [ 1731.080784] Key type ._llcrypt unregistered [ 1766.618700] Key type ._llcrypt registered [ 1766.620416] Key type .llcrypt registered [ 1768.158637] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 14:18:55 (1787077135) [ 1771.712489] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1771.764794] alg: No test for adler32 (adler32-zlib) [ 1773.029254] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 1773.307880] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 1775.120207] Key type lgssc registered [ 1776.629296] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1831.636760] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1837.702140] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1858.060247] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1860.601286] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 1864.873184] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-1814h20m32s [ 1866.222994] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1873.273765] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1875.962471] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1896.422486] Lustre: 41930:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787077245/real 1787077245] req@0000000092816b2c x1873886201256704/t0(0) o101->lustre-MDT0000-mdc-ffff8dbf07668800@192.168.202.124@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787077265 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1896.444341] Lustre: lustre-MDT0000-mdc-ffff8dbf07668800: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1896.483164] Lustre: lustre-MDT0000-mdc-ffff8dbf07668800: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 1918.042918] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1921.290430] Lustre: DEBUG MARKER: done [ 1926.963602] Lustre: Unmounted lustre-client [ 1955.194441] Key type lgssc unregistered [ 1955.369476] LNet: 42816:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1955.373465] LNetError: 42816:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1955.392559] LNet: Removed LNI 192.168.202.24@tcp [ 1955.998497] Key type .llcrypt unregistered [ 1956.000890] Key type ._llcrypt unregistered [ 1981.912905] Key type ._llcrypt registered [ 1981.915898] Key type .llcrypt registered [ 1982.881876] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 14:22:31 (1787077351) [ 1984.728947] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1986.642545] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 14:22:34 (1787077354) [ 1990.980260] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1991.030509] alg: No test for adler32 (adler32-zlib) [ 1992.230269] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 1992.681402] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 1994.435546] Key type lgssc registered [ 1995.963187] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2022.578574] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 14:23:10 (1787077390) [ 2057.388987] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2063.436676] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2088.263183] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2089.885560] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 2093.345727] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2097.314723] Lustre: Unmounted lustre-client [ 2114.641547] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2163.141930] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2169.107205] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2169.938892] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 2173.860480] Lustre: Unmounted lustre-client [ 2233.521702] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2239.312260] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2239.868259] LustreError: 44230:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 2239.950882] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 2243.198562] Lustre: Unmounted lustre-client [ 2261.242776] Lustre: DEBUG MARKER: files compared the same [ 2283.631640] Key type lgssc unregistered [ 2283.863821] LNet: 50435:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2283.875086] LNetError: 50435:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2283.891779] LNet: Removed LNI 192.168.202.24@tcp [ 2284.644650] Key type .llcrypt unregistered [ 2284.646760] Key type ._llcrypt unregistered [ 2298.804907] Key type ._llcrypt registered [ 2298.809157] Key type .llcrypt registered [ 2300.152329] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 14:27:47 (1787077667) [ 2302.526194] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2302.540732] alg: No test for adler32 (adler32-zlib) [ 2303.562148] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 2303.837240] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 2305.560185] Key type lgssc registered [ 2306.947882] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2358.909097] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2363.958490] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2383.570423] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2385.130239] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 2388.768316] Lustre: Unmounted lustre-client [ 2421.013289] Key type lgssc unregistered [ 2421.212694] LNet: 54015:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2421.232264] LNetError: 54015:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2421.248067] LNet: Removed LNI 192.168.202.24@tcp [ 2421.912943] Key type .llcrypt unregistered [ 2421.917879] Key type ._llcrypt unregistered [ 2435.066666] Key type ._llcrypt registered [ 2435.068650] Key type .llcrypt registered [ 2436.005559] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 14:30:04 (1787077804) [ 2437.748079] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2437.807265] alg: No test for adler32 (adler32-zlib) [ 2438.852753] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 2439.023180] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 2440.688249] Key type lgssc registered [ 2441.622425] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2519.829499] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2549.288303] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2554.172504] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2587.432648] Key type lgssc unregistered [ 2587.708611] LNet: 57503:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2587.716338] LNetError: 57503:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2587.731908] LNet: Removed LNI 192.168.202.24@tcp [ 2588.251871] Key type .llcrypt unregistered [ 2588.254185] Key type ._llcrypt unregistered [ 2600.425634] Key type ._llcrypt registered [ 2600.427533] Key type .llcrypt registered [ 2601.394305] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 14:32:49 (1787077969) [ 2604.306378] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2604.325706] alg: No test for adler32 (adler32-zlib) [ 2605.323602] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 2605.521410] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 2607.200195] Key type lgssc registered [ 2608.411409] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2673.682373] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 2680.478752] Lustre: Unmounted lustre-client [ 2712.314732] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 14:34:40 (1787078080) [ 2815.622981] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2833.454797] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 2840.253147] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2840.256972] LustreError: 63972:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8dbf0725d000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2840.276134] Lustre: 58485:0:(llite_lib.c:4390:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.124@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2850.613910] Lustre: Unmounted lustre-client [ 2890.005566] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 14:37:38 (1787078258) [ 2898.997565] Key type lgssc unregistered [ 2899.176979] LNet: 65193:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2899.184757] LNetError: 65193:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2900.200408] LNet: Removed LNI 192.168.202.24@tcp [ 2900.784557] Key type .llcrypt unregistered [ 2900.786376] Key type ._llcrypt unregistered [ 2910.961683] Key type ._llcrypt registered [ 2910.966053] Key type .llcrypt registered [ 2911.418227] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2911.444914] alg: No test for adler32 (adler32-zlib) [ 2912.459450] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 2912.637403] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 2914.288188] Key type lgssc registered [ 2915.208517] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2952.885234] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2957.569437] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2973.674961] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2979.389154] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 2982.673635] Lustre: Unmounted lustre-client [ 3006.764088] Key type lgssc unregistered [ 3006.966356] LNet: 68204:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3006.972907] LNetError: 68204:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3006.988203] LNet: Removed LNI 192.168.202.24@tcp [ 3007.455408] Key type .llcrypt unregistered [ 3007.456786] Key type ._llcrypt unregistered [ 3015.970260] Key type ._llcrypt registered [ 3015.973165] Key type .llcrypt registered [ 3016.253616] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3016.261884] alg: No test for adler32 (adler32-zlib) [ 3017.255865] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 3017.429447] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 3019.096205] Key type lgssc registered [ 3019.985314] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3107.930462] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3112.271634] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3127.158191] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3139.083298] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 3140.231456] Lustre: Unmounted lustre-client [ 3162.544519] Key type lgssc unregistered [ 3162.719707] LNet: 71631:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3162.728737] LNetError: 71631:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3162.738987] LNet: Removed LNI 192.168.202.24@tcp [ 3163.221380] Key type .llcrypt unregistered [ 3163.224978] Key type ._llcrypt unregistered [ 3174.852130] Key type ._llcrypt registered [ 3174.853613] Key type .llcrypt registered [ 3175.927285] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 14:42:24 (1787078544) [ 3177.726985] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3177.743669] alg: No test for adler32 (adler32-zlib) [ 3178.806505] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 3179.034500] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 3180.736553] Key type lgssc registered [ 3181.737898] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3215.708287] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3219.957966] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3235.824672] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3246.629543] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 3250.779207] Lustre: Unmounted lustre-client [ 3251.142293] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 3252.916157] Lustre: Unmounted lustre-client [ 3274.807521] Key type lgssc unregistered [ 3275.019604] LNet: 75315:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3275.029747] LNetError: 75315:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3275.042500] LNet: Removed LNI 192.168.202.24@tcp [ 3275.408598] Key type .llcrypt unregistered [ 3275.411556] Key type ._llcrypt unregistered [ 3283.124849] Key type ._llcrypt registered [ 3283.126470] Key type .llcrypt registered [ 3283.408830] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3283.419848] alg: No test for adler32 (adler32-zlib) [ 3284.392243] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 3284.536419] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 3286.136227] Key type lgssc registered [ 3286.990595] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3319.471245] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3322.971512] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3334.906895] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3336.380254] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 3342.812206] Lustre: Unmounted lustre-client [ 3371.977768] Key type lgssc unregistered [ 3372.119842] LNet: 78340:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3372.126442] LNetError: 78340:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3372.138070] LNet: Removed LNI 192.168.202.24@tcp [ 3372.506487] Key type .llcrypt unregistered [ 3372.509869] Key type ._llcrypt unregistered [ 3380.410230] Key type ._llcrypt registered [ 3380.411212] Key type .llcrypt registered [ 3381.104792] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 14:45:49 (1787078749) [ 3382.397456] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3382.415242] alg: No test for adler32 (adler32-zlib) [ 3383.354240] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 3383.520493] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 3385.176412] Key type lgssc registered [ 3385.923928] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3412.898585] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3415.570662] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3427.277604] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3429.670515] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 3436.507590] Lustre: lustre: root_squash is set to 0:0 [ 3444.221396] Lustre: lustre: nosquash_nids is cleared [ 3444.240381] Lustre: lustre: root_squash is set to 500:500 [ 3454.091891] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.24@tcp 192.168.0.[2,10]@tcp [ 3463.183139] Lustre: lustre: nosquash_nids set to 192.168.202.24/24@tcp [ 3464.363131] Lustre: Unmounted lustre-client [ 3490.979840] Key type lgssc unregistered [ 3491.141322] LNet: 82309:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3491.153364] LNetError: 82309:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3491.168953] LNet: Removed LNI 192.168.202.24@tcp [ 3491.630263] Key type .llcrypt unregistered [ 3491.635287] Key type ._llcrypt unregistered [ 3501.116465] Key type ._llcrypt registered [ 3501.119370] Key type .llcrypt registered [ 3501.842510] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 14:47:50 (1787078870) [ 3503.270384] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3504.289474] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 14:47:52 (1787078872) [ 3505.879627] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3505.919996] alg: No test for adler32 (adler32-zlib) [ 3506.894907] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 3507.076457] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 3508.712176] Key type lgssc registered [ 3509.676849] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3539.567497] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3542.844024] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3554.609505] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3554.936585] Lustre: lustre: root_squash is set to 500:500 [ 3554.967678] Lustre: lustre: nosquash_nids set to 192.168.202.24/24@tcp [ 3556.035461] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 3563.065437] Lustre: Unmounted lustre-client [ 3584.427886] Key type lgssc unregistered [ 3584.639225] LNet: 86262:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3584.644093] LNetError: 86262:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3584.659964] LNet: Removed LNI 192.168.202.24@tcp [ 3585.118783] Key type .llcrypt unregistered [ 3585.120572] Key type ._llcrypt unregistered [ 3595.403989] Key type ._llcrypt registered [ 3595.406569] Key type .llcrypt registered [ 3596.321184] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3597.418892] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 14:49:25 (1787078965) [ 3608.369399] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3608.379099] alg: No test for adler32 (adler32-zlib) [ 3609.312261] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 3609.460702] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 3611.080780] Key type lgssc registered [ 3611.754460] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3657.571678] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3660.195759] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3671.185611] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3717.293932] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3720.303328] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3731.918909] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3739.957675] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 3758.800417] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8dbf0473e800.ost_server_uuid 50 [ 3759.615460] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8dbf0473e800.ost_server_uuid in FULL state after 0 sec [ 3759.790280] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 3760.918070] Lustre: Unmounted lustre-client [ 3761.454947] Lustre: Unmounted lustre-client [ 3804.156814] Key type lgssc unregistered [ 3804.317479] LNet: 93904:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3804.331903] LNetError: 93904:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3804.353832] LNet: Removed LNI 192.168.202.24@tcp [ 3804.744934] Key type .llcrypt unregistered [ 3804.746632] Key type ._llcrypt unregistered [ 3820.754291] Key type ._llcrypt registered [ 3820.756313] Key type .llcrypt registered [ 3821.432139] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 14:53:09 (1787079189) [ 3830.390352] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3830.409318] alg: No test for adler32 (adler32-zlib) [ 3831.336090] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 3831.433635] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 3833.032182] Key type lgssc registered [ 3833.670598] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3874.152571] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3876.744893] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3887.054120] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3888.270582] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 3903.970857] Lustre: lustre-OST0000-osc-ffff8dbf04ef6000: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3909.092165] Lustre: lustre-MDT0000-mdc-ffff8dbf04ef6000: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3910.112526] Lustre: 95264:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787079263/real 1787079263] req@00000000b5ad983c x1873888359224448/t0(0) o400->lustre-OST0000-osc-ffff8dbf04ef6000@192.168.202.124@tcp:28/4 lens 224/224 e 0 to 1 dl 1787079279 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3915.232139] Lustre: 95263:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787079268/real 1787079268] req@00000000ab9dbc7a x1873888359224960/t0(0) o400->lustre-OST0000-osc-ffff8dbf04ef6000@192.168.202.124@tcp:28/4 lens 224/224 e 0 to 1 dl 1787079284 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3924.452758] LustreError: MGC192.168.202.124@tcp: Connection to MGS (at 192.168.202.124@tcp) was lost; in progress operations using this service will fail [ 3924.470791] Lustre: 98428:0:(mgc_request.c:1899:mgc_process_log()) MGC192.168.202.124@tcp: IR log lustre-cliir failed, not fatal: rc = -5 [ 3924.477810] Lustre: Evicted from MGS (at 192.168.202.124@tcp) after server handle changed from 0x5f5c081186ea2cf8 to 0x5f5c081186ea2f9f [ 3924.483656] Lustre: MGC192.168.202.124@tcp: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 3926.438243] Lustre: lustre-MDT0000-mdc-ffff8dbf04ef6000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 3926.945857] Lustre: Unmounted lustre-client [ 3945.564716] Key type lgssc unregistered [ 3945.753274] LNet: 99547:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3945.759420] LNetError: 99547:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3945.774653] LNet: Removed LNI 192.168.202.24@tcp [ 3946.163820] Key type .llcrypt unregistered [ 3946.166333] Key type ._llcrypt unregistered [ 3958.810182] Key type ._llcrypt registered [ 3958.816276] Key type .llcrypt registered [ 3960.705870] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 14:55:27 (1787079327) [ 3976.213405] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3976.270424] alg: No test for adler32 (adler32-zlib) [ 3977.492670] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 3977.855320] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 3979.576123] Key type lgssc registered [ 3980.869982] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4037.443914] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4126.491812] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4131.856849] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4152.479097] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4155.055953] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 4156.687093] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4158.432618] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 14:58:46 (1787079526) [ 4345.548555] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4355.890992] Lustre: Unmounted lustre-client [ 4478.613827] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4485.433546] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4508.281571] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4546.208377] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 15:05:14 (1787079914) [ 4626.632181] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4631.293823] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4648.969492] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4649.616130] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 4652.693195] Lustre: Unmounted lustre-client [ 4679.361564] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 15:07:27 (1787080047) [ 4755.563496] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4760.817590] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4779.780719] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4780.243667] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 4782.938514] Lustre: Unmounted lustre-client [ 4806.575201] Key type lgssc unregistered [ 4806.776375] LNet: 122560:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4806.786115] LNetError: 122560:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4806.814960] LNet: Removed LNI 192.168.202.24@tcp [ 4807.359697] Key type .llcrypt unregistered [ 4807.361790] Key type ._llcrypt unregistered [ 4820.298165] Key type ._llcrypt registered [ 4820.300329] Key type .llcrypt registered [ 4821.387040] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 15:09:49 (1787080189) [ 4823.469950] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4823.480869] alg: No test for adler32 (adler32-zlib) [ 4824.508441] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 4824.732374] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 4826.408183] Key type lgssc registered [ 4827.267461] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4865.688653] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4869.703155] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4886.320994] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4893.203141] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 4905.661981] Lustre: Unmounted lustre-client [ 4930.121919] Key type lgssc unregistered [ 4930.323982] LNet: 126157:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4930.328932] LNetError: 126157:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4930.346729] LNet: Removed LNI 192.168.202.24@tcp [ 4930.837117] Key type .llcrypt unregistered [ 4930.839856] Key type ._llcrypt unregistered [ 4942.969935] Key type ._llcrypt registered [ 4942.974931] Key type .llcrypt registered [ 4944.146748] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 15:11:52 (1787080312) [ 4946.067921] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4946.083476] alg: No test for adler32 (adler32-zlib) [ 4947.132561] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 4947.314622] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 4948.952180] Key type lgssc registered [ 4949.916281] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4986.978940] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4990.909952] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5006.326917] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5018.154353] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 5023.209200] Lustre: lustre-OST0000-osc-ffff8dbf04e8f000: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5033.794184] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8dbf04e8f000.ost_server_uuid 50 [ 5034.960560] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5045.925358] Lustre: Unmounted lustre-client [ 5063.491854] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 15:13:51 (1787080431) [ 5084.891621] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5088.316745] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5101.224850] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5117.390881] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5117.888292] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 5123.046727] Lustre: lustre-OST0000-osc-ffff8dbf096b5000: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5142.312199] Lustre: Unmounted lustre-client [ 5176.786688] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 15:15:45 (1787080545) [ 5198.205428] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5201.606296] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5214.037698] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5226.088847] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5226.549215] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 5231.607142] Lustre: lustre-OST0000-osc-ffff8dbf03f02000: Connection to lustre-OST0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5245.466389] Lustre: Unmounted lustre-client [ 5276.298320] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 15:17:24 (1787080644) [ 5331.780634] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5335.579436] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5350.473351] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5391.897605] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5394.730158] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5405.943903] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5426.221264] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 5459.156776] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5472.581880] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 12 sec [ 5473.914305] Lustre: Unmounted lustre-client [ 5505.847156] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 15:21:14 (1787080874) [ 5524.033991] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5526.856883] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5540.163459] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5560.197369] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5578.536114] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 5609.883656] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5610.797531] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5614.567078] Lustre: lustre-OST0001-osc-ffff8dbf04e8c000: Connection to lustre-OST0001 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5619.322901] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5629.663129] Lustre: Unmounted lustre-client [ 5666.410606] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 15:23:54 (1787081034) [ 5682.950940] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5685.963257] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5697.242501] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5697.535953] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 5710.223156] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5711.128876] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5719.422585] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8dbf096b5000.ost_server_uuid 50 [ 5720.214793] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8dbf096b5000.ost_server_uuid in FULL state after 0 sec [ 5721.572307] Lustre: Unmounted lustre-client [ 5721.714212] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 5721.717158] Lustre: Skipped 3 previous similar messages [ 5721.797757] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 5722.511525] LustreError: 149598:0:(sec.c:403:import_sec_validate_get()) import 000000008174b720 (NEW) with no sec [ 5773.934942] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 15:25:42 (1787081142) [ 5793.866556] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5797.143467] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5811.025336] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5839.609424] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5840.479919] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5840.683214] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 5857.177764] Lustre: Unmounted lustre-client [ 5857.183368] Lustre: Skipped 1 previous similar message [ 5906.711619] Key type lgssc unregistered [ 5907.083746] LNet: 153001:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5907.106450] LNetError: 153001:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5907.131965] LNet: Removed LNI 192.168.202.24@tcp [ 5908.017169] Key type .llcrypt unregistered [ 5908.019511] Key type ._llcrypt unregistered [ 5925.973610] Key type ._llcrypt registered [ 5925.975259] Key type .llcrypt registered [ 5927.527614] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 15:28:15 (1787081295) [ 5928.802058] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5928.812573] alg: No test for adler32 (adler32-zlib) [ 5930.021514] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 5930.329281] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 5932.072305] Key type lgssc registered [ 5933.577460] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5978.397421] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5983.039482] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6000.808822] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6019.223688] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6019.760359] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6020.887933] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 6029.832130] LustreError: lustre-MDT0001-mdc-ffff8dbf04e8b000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6029.847713] Lustre: lustre-MDT0001-mdc-ffff8dbf04e8b000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 6036.103884] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6037.349217] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6059.018816] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6062.353822] Lustre: Unmounted lustre-client [ 6082.862893] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 15:30:51 (1787081451) [ 6149.793717] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6153.391849] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6171.006815] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6171.626683] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 6192.646458] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6193.949281] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6196.214686] Lustre: lustre-OST0001-osc-ffff8dbf07247000: Connection to lustre-OST0001 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6204.292554] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6214.605433] Lustre: Unmounted lustre-client [ 6252.637472] Key type lgssc unregistered [ 6252.849777] LNet: 162645:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6252.855561] LNetError: 162645:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6252.866293] LNet: Removed LNI 192.168.202.24@tcp [ 6253.386548] Key type .llcrypt unregistered [ 6253.388434] Key type ._llcrypt unregistered [ 6272.641069] Key type ._llcrypt registered [ 6272.642344] Key type .llcrypt registered [ 6273.402770] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 15:34:01 (1787081641) [ 6274.626238] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6274.635460] alg: No test for adler32 (adler32-zlib) [ 6275.553906] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 6275.721913] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 6277.473199] Key type lgssc registered [ 6278.964605] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6351.947349] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6360.336207] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6381.167258] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6383.901299] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 6426.474493] Lustre: Unmounted lustre-client [ 6469.417618] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6470.156712] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 6508.214725] Lustre: Unmounted lustre-client [ 6544.209404] Key type lgssc unregistered [ 6544.436175] LNet: 167097:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6544.446242] LNetError: 167097:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6544.475374] LNet: Removed LNI 192.168.202.24@tcp [ 6545.416826] Key type .llcrypt unregistered [ 6545.419991] Key type ._llcrypt unregistered [ 6563.334806] Key type ._llcrypt registered [ 6563.341626] Key type .llcrypt registered [ 6565.212214] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 15:38:52 (1787081932) [ 6568.230960] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6568.306350] alg: No test for adler32 (adler32-zlib) [ 6569.439293] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 6569.793327] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 6571.593082] Key type lgssc registered [ 6572.989322] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6632.603883] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6639.242813] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6661.217243] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6674.012897] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 6694.215719] Lustre: Unmounted lustre-client [ 6722.050251] Key type lgssc unregistered [ 6722.262260] LNet: 170866:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6722.266221] LNetError: 170866:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6723.303328] LNet: Removed LNI 192.168.202.24@tcp [ 6724.431765] Key type .llcrypt unregistered [ 6724.433370] Key type ._llcrypt unregistered [ 6740.394407] Key type ._llcrypt registered [ 6740.398663] Key type .llcrypt registered [ 6740.930662] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6740.964391] alg: No test for adler32 (adler32-zlib) [ 6742.238113] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 6742.614131] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 6744.314050] Key type lgssc registered [ 6745.876767] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6808.095211] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6814.425131] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6838.998573] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6841.018255] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 6849.069076] Lustre: Unmounted lustre-client [ 6886.155551] Key type lgssc unregistered [ 6886.429421] LNet: 173939:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6886.435226] LNetError: 173939:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6887.468649] LNet: Removed LNI 192.168.202.24@tcp [ 6888.185857] Key type .llcrypt unregistered [ 6888.188918] Key type ._llcrypt unregistered [ 6906.106270] Key type ._llcrypt registered [ 6906.114360] Key type .llcrypt registered [ 6908.296748] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 15:44:35 (1787082275) [ 6911.127613] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6911.270554] alg: No test for adler32 (adler32-zlib) [ 6912.552382] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 6912.954330] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 6914.640486] Key type lgssc registered [ 6916.857726] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6968.375946] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6974.126702] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6994.760637] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6996.239964] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 7016.364329] Lustre: Unmounted lustre-client [ 7045.279426] Key type lgssc unregistered [ 7045.582618] LNet: 177700:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7045.597631] LNetError: 177700:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7045.616768] LNet: Removed LNI 192.168.202.24@tcp [ 7046.534334] Key type .llcrypt unregistered [ 7046.547771] Key type ._llcrypt unregistered [ 7062.107550] Key type ._llcrypt registered [ 7062.112377] Key type .llcrypt registered [ 7062.857758] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7062.880344] alg: No test for adler32 (adler32-zlib) [ 7063.962818] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 7064.287563] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 7066.090258] Key type lgssc registered [ 7067.808780] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7120.782351] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7126.430433] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7147.927055] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7149.601158] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 7158.790768] Lustre: Unmounted lustre-client [ 7189.598611] Key type lgssc unregistered [ 7189.981663] LNet: 180769:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7189.986905] LNetError: 180769:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7190.015067] LNet: Removed LNI 192.168.202.24@tcp [ 7191.060449] Key type .llcrypt unregistered [ 7191.066079] Key type ._llcrypt unregistered [ 7209.294946] Key type ._llcrypt registered [ 7209.298607] Key type .llcrypt registered [ 7211.216517] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 15:49:38 (1787082578) [ 7234.878404] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7234.943915] alg: No test for adler32 (adler32-zlib) [ 7236.134561] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 7236.435734] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 7238.170735] Key type lgssc registered [ 7239.386494] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7327.355433] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7333.891394] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7358.036329] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7399.768116] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 15:52:47 (1787082767) [ 7429.908042] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7435.067293] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7457.073600] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7459.852206] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 7465.130097] Lustre: Unmounted lustre-client [ 7494.581952] Key type lgssc unregistered [ 7495.009891] LNet: 187882:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7495.017279] LNetError: 187882:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7495.041638] LNet: Removed LNI 192.168.202.24@tcp [ 7495.990435] Key type .llcrypt unregistered [ 7495.996554] Key type ._llcrypt unregistered [ 7513.240803] Key type ._llcrypt registered [ 7513.242939] Key type .llcrypt registered [ 7514.920979] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 7516.334525] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 15:54:44 (1787082884) [ 7536.135981] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7536.152402] alg: No test for adler32 (adler32-zlib) [ 7537.340701] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 7537.615588] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 7539.326535] Key type lgssc registered [ 7541.164906] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7652.125527] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7658.941320] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7684.836435] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7708.736419] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7711.479451] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 7736.176137] Lustre: Unmounted lustre-client [ 7870.857268] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7877.132842] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7900.817557] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7940.851644] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 16:01:48 (1787083308) [ 7942.425379] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 7943.998828] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 16:01:52 (1787083312) [ 8037.297951] Key type lgssc unregistered [ 8037.544086] LNet: 199340:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8037.552170] LNetError: 199340:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8037.580421] LNet: Removed LNI 192.168.202.24@tcp [ 8038.175871] Key type .llcrypt unregistered [ 8038.179506] Key type ._llcrypt unregistered [ 8053.343918] Key type ._llcrypt registered [ 8053.346947] Key type .llcrypt registered [ 8054.625974] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 16:03:42 (1787083422) [ 8094.638304] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8094.657239] alg: No test for adler32 (adler32-zlib) [ 8095.749330] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 8096.012388] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 8097.721270] Key type lgssc registered [ 8098.783026] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8140.358130] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8145.686884] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8179.710345] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8207.193664] Key type lgssc unregistered [ 8207.567944] LNet: 203076:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8207.578423] LNetError: 203076:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8207.601810] LNet: Removed LNI 192.168.202.24@tcp [ 8208.367613] Key type .llcrypt unregistered [ 8208.370746] Key type ._llcrypt unregistered [ 8223.322637] Key type ._llcrypt registered [ 8223.326187] Key type .llcrypt registered [ 8224.475523] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 16:06:32 (1787083592) [ 8226.827763] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8226.839925] alg: No test for adler32 (adler32-zlib) [ 8227.893397] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 8228.127112] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 8229.824773] Key type lgssc registered [ 8231.026688] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8280.926811] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8286.829802] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8310.728636] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8313.566118] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 8324.075745] Lustre: lustre-MDT0000-mdc-ffff8dbf07072000: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8329.190478] Lustre: lustre-MDT0001-mdc-ffff8dbf07072000: Connection to lustre-MDT0001 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8345.568318] Lustre: 204067:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787083698/real 1787083698] req@00000000e8686dc2 x1873892969890048/t0(0) o400->MGC192.168.202.124@tcp@192.168.202.124@tcp:26/25 lens 224/224 e 0 to 1 dl 1787083714 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 8345.602796] LustreError: MGC192.168.202.124@tcp: Connection to MGS (at 192.168.202.124@tcp) was lost; in progress operations using this service will fail [ 8354.865950] Lustre: Evicted from MGS (at 192.168.202.124@tcp) after server handle changed from 0xb4f816d99c7cdd2b to 0xb4f816d99c7cfa74 [ 8354.896608] Lustre: MGC192.168.202.124@tcp: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 8374.784821] LustreError: lustre-MDT0000-mdc-ffff8dbf07072000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 8374.810097] Lustre: lustre-MDT0000-mdc-ffff8dbf07072000: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 8380.370850] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8381.851261] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8387.616490] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8389.198211] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8392.763313] Lustre: Unmounted lustre-client [ 8418.959290] Key type lgssc unregistered [ 8419.178945] LNet: 208027:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8419.183284] LNetError: 208027:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8419.204447] LNet: Removed LNI 192.168.202.24@tcp [ 8419.847965] Key type .llcrypt unregistered [ 8419.850674] Key type ._llcrypt unregistered [ 8433.436210] Key type ._llcrypt registered [ 8433.439488] Key type .llcrypt registered [ 8434.572702] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 16:10:02 (1787083802) [ 8436.611080] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8436.637339] alg: No test for adler32 (adler32-zlib) [ 8437.719910] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 8437.945876] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 8439.584192] Key type lgssc registered [ 8440.653891] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8482.295506] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8487.244787] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8533.191738] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8539.296924] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8570.061703] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8589.357590] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8634.469688] Key type lgssc unregistered [ 8634.669696] LNet: 213321:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8634.674560] LNetError: 213321:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8634.705484] LNet: Removed LNI 192.168.202.24@tcp [ 8635.370869] Key type .llcrypt unregistered [ 8635.375356] Key type ._llcrypt unregistered [ 8672.271406] Key type ._llcrypt registered [ 8672.273482] Key type .llcrypt registered [ 8673.547304] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 16:14:01 (1787084041) [ 8702.075773] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8702.162956] alg: No test for adler32 (adler32-zlib) [ 8703.224587] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 8703.425783] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 8705.064209] Key type lgssc registered [ 8706.153046] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8765.099684] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8768.764509] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8781.302279] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8817.264392] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 16:16:25 (1787084185) [ 8821.211790] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 16:16:29 (1787084189) [ 8839.035904] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8842.132969] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8852.973665] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8855.382041] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 8863.158527] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 8864.361824] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 8865.382418] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 8866.527299] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 8870.885077] Lustre: lustre-MDT0000-mdc-ffff8dbf044c5800: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8886.251581] LustreError: MGC192.168.202.124@tcp: Connection to MGS (at 192.168.202.124@tcp) was lost; in progress operations using this service will fail [ 8886.276410] Lustre: Evicted from MGS (at 192.168.202.124@tcp) after server handle changed from 0x983f2a2755b5e7ff to 0x983f2a2755b5ea75 [ 8886.293762] Lustre: MGC192.168.202.124@tcp: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 8888.244709] Lustre: lustre-MDT0000-mdc-ffff8dbf044c5800: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 8891.646152] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8892.534318] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8894.801527] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 8896.486947] Lustre: lustre-MDT0000-mdc-ffff8dbf044c5800: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8911.842870] Lustre: 215216:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787084265/real 1787084265] req@000000009af52ca2 x1873893467897856/t0(0) o400->MGC192.168.202.124@tcp@192.168.202.124@tcp:26/25 lens 224/224 e 0 to 1 dl 1787084281 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 8911.855167] LustreError: MGC192.168.202.124@tcp: Connection to MGS (at 192.168.202.124@tcp) was lost; in progress operations using this service will fail [ 8911.891835] Lustre: Evicted from MGS (at 192.168.202.124@tcp) after server handle changed from 0x983f2a2755b5ea75 to 0x983f2a2755b5ed85 [ 8911.898173] Lustre: MGC192.168.202.124@tcp: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 8916.927922] Lustre: lustre-MDT0000-mdc-ffff8dbf044c5800: Connection restored to 192.168.202.124@tcp (at 192.168.202.124@tcp) [ 8920.637845] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8921.735406] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 8924.399878] Lustre: Unmounted lustre-client [ 8972.885471] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8976.190436] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8988.687676] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8989.013492] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 8995.390078] Lustre: Unmounted lustre-client [ 9015.357050] Key type lgssc unregistered [ 9015.523656] LNet: 225767:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9015.527674] LNetError: 225767:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9015.538921] LNet: Removed LNI 192.168.202.24@tcp [ 9015.865328] Key type .llcrypt unregistered [ 9015.866842] Key type ._llcrypt unregistered [ 9023.690824] Key type ._llcrypt registered [ 9023.694797] Key type .llcrypt registered [ 9024.483804] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 16:19:52 (1787084392) [ 9026.835201] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9026.844436] alg: No test for adler32 (adler32-zlib) [ 9027.775692] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 9027.930579] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 9029.552164] Key type lgssc registered [ 9030.248419] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9060.118942] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9063.154156] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9074.180944] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9076.539190] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 9084.044185] Lustre: Unmounted lustre-client [ 9127.296848] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9130.208664] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9141.146673] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9141.494971] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 9147.962691] Lustre: Unmounted lustre-client [ 9195.287356] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9198.768444] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9211.388711] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9211.745730] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 9212.432283] Lustre: Unmounted lustre-client [ 9232.744616] Key type lgssc unregistered [ 9232.884861] LNet: 232791:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9232.889534] LNetError: 232791:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9233.963230] LNet: Removed LNI 192.168.202.24@tcp [ 9234.353978] Key type .llcrypt unregistered [ 9234.355556] Key type ._llcrypt unregistered [ 9241.910133] Key type ._llcrypt registered [ 9241.911468] Key type .llcrypt registered [ 9242.562991] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 16:23:31 (1787084611) [ 9244.369151] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9244.378271] alg: No test for adler32 (adler32-zlib) [ 9245.321785] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 9245.451817] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 9247.048644] Key type lgssc registered [ 9247.706447] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9270.088108] Key type lgssc unregistered [ 9270.225599] LNet: 235110:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9270.229981] LNetError: 235110:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9270.240578] LNet: Removed LNI 192.168.202.24@tcp [ 9270.563125] Key type .llcrypt unregistered [ 9270.565395] Key type ._llcrypt unregistered [ 9284.800095] Key type ._llcrypt registered [ 9284.803079] Key type .llcrypt registered [ 9285.013654] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9285.019767] alg: No test for adler32 (adler32-zlib) [ 9285.949226] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 9286.079660] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 9287.720149] Key type lgssc registered [ 9288.277255] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9331.818390] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9334.666126] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9345.914642] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9370.398205] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 9371.149675] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 16:25:39 (1787084739) [ 9386.284328] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9389.035674] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9399.158343] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9410.801918] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9412.160243] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 9417.190147] Lustre: lustre-OST0001-osc-ffff8dbf05e64800: Connection to lustre-OST0001 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9420.462465] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9430.736562] Lustre: Unmounted lustre-client [ 9457.010743] Key type lgssc unregistered [ 9457.137550] LNet: 242201:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9457.141856] LNetError: 242201:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9457.154177] LNet: Removed LNI 192.168.202.24@tcp [ 9457.483707] Key type .llcrypt unregistered [ 9457.485156] Key type ._llcrypt unregistered [ 9473.425401] Key type ._llcrypt registered [ 9473.431540] Key type .llcrypt registered [ 9474.185876] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 16:27:22 (1787084842) [ 9481.022309] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9481.085255] alg: No test for adler32 (adler32-zlib) [ 9482.033693] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 9482.172548] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 9483.776163] Key type lgssc registered [ 9484.538476] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9511.442630] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9514.180965] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9536.517593] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 16:28:25 (1787084905) [ 9552.312611] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9555.171611] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9564.867814] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9566.093839] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 9570.868265] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 9576.675168] Lustre: Unmounted lustre-client [ 9640.396844] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9643.085815] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9675.598902] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9681.412514] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 9682.146117] Lustre: Unmounted lustre-client [ 9692.340961] Key type lgssc unregistered [ 9692.487707] LNet: 249880:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9692.493389] LNetError: 249880:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9692.503272] LNet: Removed LNI 192.168.202.24@tcp [ 9692.865513] Key type .llcrypt unregistered [ 9692.867025] Key type ._llcrypt unregistered [ 9705.766020] Key type ._llcrypt registered [ 9705.767746] Key type .llcrypt registered [ 9705.970561] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9705.976564] alg: No test for adler32 (adler32-zlib) [ 9706.882476] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 9706.984938] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 9708.576194] Key type lgssc registered [ 9709.073277] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9749.143767] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9751.841668] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9762.793802] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9788.273936] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 9789.257628] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 16:32:37 (1787085157) [ 9806.437423] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9809.396892] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9820.146938] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9822.954233] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 9829.544473] Lustre: Unmounted lustre-client [ 9850.791870] Key type lgssc unregistered [ 9850.948943] LNet: 256491:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9850.955848] LNetError: 256491:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9850.967522] LNet: Removed LNI 192.168.202.24@tcp [ 9851.312706] Key type .llcrypt unregistered [ 9851.317829] Key type ._llcrypt unregistered [ 9857.859992] Key type ._llcrypt registered [ 9857.862991] Key type .llcrypt registered [ 9858.528816] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 9859.341926] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 16:33:48 (1787085228) [ 9863.990274] Key type .llcrypt unregistered [ 9863.992363] Key type ._llcrypt unregistered [ 9867.845266] Key type ._llcrypt registered [ 9867.847076] Key type .llcrypt registered [ 9868.088378] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9868.097232] alg: No test for adler32 (adler32-zlib) [ 9869.001136] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 9869.130186] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 9870.736876] Key type lgssc registered [ 9871.384652] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9895.353295] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9907.226144] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [ 9908.346235] Lustre: Unmounted lustre-client [ 9923.651641] Key type lgssc unregistered [ 9923.796709] LNet: 259941:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9923.800233] LNetError: 259941:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9923.820397] LNet: Removed LNI 192.168.202.24@tcp [ 9924.138318] Key type .llcrypt unregistered [ 9924.139789] Key type ._llcrypt unregistered [ 9930.775733] Key type ._llcrypt registered [ 9930.777224] Key type .llcrypt registered [ 9931.402577] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 16:35:00 (1787085300) [ 9932.429872] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9932.439032] alg: No test for adler32 (adler32-zlib) [ 9933.315969] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [ 9933.426664] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [ 9935.024172] Key type lgssc registered [ 9935.493957] Lustre: Echo OBD driver; http://www.lustre.org/ [10000.296687] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10016.249391] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10018.801235] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10020.039881] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [10020.665160] Lustre: Unmounted lustre-client [10039.728241] Key type lgssc unregistered [10039.862477] LNet: 263474:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10039.864667] LNetError: 263474:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10039.875072] LNet: Removed LNI 192.168.202.24@tcp [10040.185923] Key type .llcrypt unregistered [10040.187371] Key type ._llcrypt unregistered [10046.966593] Key type ._llcrypt registered [10046.968039] Key type .llcrypt registered [10047.593191] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 16:36:56 (1787085416) [10048.700015] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10048.711473] alg: No test for adler32 (adler32-zlib) [10049.647631] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [10049.759769] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [10051.376341] Key type lgssc registered [10052.024215] Lustre: Echo OBD driver; http://www.lustre.org/ [10076.794395] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10079.354834] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10088.450736] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10095.080202] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [10100.199196] Lustre: lustre-MDT0000-mdc-ffff8dbf11547800: Connection to lustre-MDT0000 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [10103.091357] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10103.101388] LustreError: 266619:0:(file.c:6156:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [10103.264599] LustreError: MGC192.168.202.124@tcp: Connection to MGS (at 192.168.202.124@tcp) was lost; in progress operations using this service will fail [10103.291110] Lustre: Unmounted lustre-client [10117.123872] Key type lgssc unregistered [10117.276401] LNet: 267035:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10117.280640] LNetError: 267035:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10117.294833] LNet: Removed LNI 192.168.202.24@tcp [10117.641579] Key type .llcrypt unregistered [10117.644426] Key type ._llcrypt unregistered [10124.905863] Key type ._llcrypt registered [10124.907588] Key type .llcrypt registered [10125.543238] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 16:38:14 (1787085494) [10126.705980] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10126.721866] alg: No test for adler32 (adler32-zlib) [10127.615548] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [10127.739109] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [10129.352172] Key type lgssc registered [10129.873589] Lustre: Echo OBD driver; http://www.lustre.org/ [10156.586197] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10159.665223] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10170.264951] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10172.604204] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [10180.890801] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [10181.554970] Lustre: Unmounted lustre-client [10194.308438] Key type lgssc unregistered [10194.436615] LNet: 270608:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10194.442360] LNetError: 270608:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10194.451594] LNet: Removed LNI 192.168.202.24@tcp [10194.789678] Key type .llcrypt unregistered [10194.790636] Key type ._llcrypt unregistered [10201.770693] Key type ._llcrypt registered [10201.773212] Key type .llcrypt registered [10202.394353] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 16:39:31 (1787085571) [10210.469904] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10210.486194] alg: No test for adler32 (adler32-zlib) [10211.394785] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [10211.510071] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [10213.104185] Key type lgssc registered [10213.611708] Lustre: Echo OBD driver; http://www.lustre.org/ [10265.660405] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10272.255934] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [10294.759662] Lustre: lustre-MDT0001-mdc-ffff8dbf07259800: Connection to lustre-MDT0001 (at 192.168.202.124@tcp) was lost; in progress operations using this service will wait for recovery to complete [10300.911816] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10311.234758] Lustre: Unmounted lustre-client [10330.793172] Key type lgssc unregistered [10330.935832] LNet: 276380:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10330.938816] LNetError: 276380:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10330.947965] LNet: Removed LNI 192.168.202.24@tcp [10331.312176] Key type .llcrypt unregistered [10331.313809] Key type ._llcrypt unregistered [10337.686626] Key type ._llcrypt registered [10337.687918] Key type .llcrypt registered [10338.320844] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 16:41:46 (1787085706) [10339.113930] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [10339.846582] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 16:41:48 (1787085708) [10340.521510] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [10341.279239] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 16:41:49 (1787085709) [10342.016992] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [10342.910582] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 16:41:51 (1787085711) [10343.737386] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [10344.561023] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 16:41:53 (1787085713) [10345.344593] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [10346.199830] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 16:41:54 (1787085714) [10350.351251] Key type .llcrypt unregistered [10350.352500] Key type ._llcrypt unregistered [10353.428330] Key type ._llcrypt registered [10353.429731] Key type .llcrypt registered [10353.623711] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10353.645823] alg: No test for adler32 (adler32-zlib) [10354.557218] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [10354.674990] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [10356.312210] Key type lgssc registered [10357.019484] Lustre: Echo OBD driver; http://www.lustre.org/ [10391.337603] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10393.596606] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10402.568769] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10408.933658] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [10409.509150] Lustre: Unmounted lustre-client [10434.067633] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 16:43:22 (1787085802) [10448.619220] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10451.040088] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10472.665061] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10488.308816] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [10488.731064] Lustre: Unmounted lustre-client [10519.826306] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 16:44:48 (1787085888) [10527.776120] LNet: 1 local NIs in recovery (showing 1): 192.168.202.24@tcp [11109.773937] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11111.598599] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11131.756604] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11180.927097] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 16:55:49 (1787086549) [11185.088363] Key type lgssc unregistered [11185.206439] LNet: 289863:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11185.209112] LNetError: 289863:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11185.217075] LNet: Removed LNI 192.168.202.24@tcp [11185.475674] Key type .llcrypt unregistered [11185.477229] Key type ._llcrypt unregistered [11260.418089] Key type ._llcrypt registered [11260.421757] Key type .llcrypt registered [11260.530349] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11260.542777] alg: No test for adler32 (adler32-zlib) [11261.405692] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [11261.491456] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [11263.080214] Key type lgssc registered [11263.502902] Lustre: Echo OBD driver; http://www.lustre.org/ [11293.727090] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11295.387888] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11302.912637] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11321.748167] Key type lgssc unregistered [11321.884632] LNet: 293537:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11321.892341] LNetError: 293537:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11321.902471] LNet: Removed LNI 192.168.202.24@tcp [11322.196231] Key type .llcrypt unregistered [11322.197758] Key type ._llcrypt unregistered [11350.553945] Key type ._llcrypt registered [11350.554781] Key type .llcrypt registered [11350.988241] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 16:58:39 (1787086719) [11357.933766] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11357.941649] alg: No test for adler32 (adler32-zlib) [11358.789977] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [11358.879497] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [11360.456137] Key type lgssc registered [11360.804784] Lustre: Echo OBD driver; http://www.lustre.org/ [11376.820761] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 16:59:05 (1787086745) [11380.613632] Key type lgssc unregistered [11380.730530] LNet: 297089:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11380.733369] LNetError: 297089:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11380.742386] LNet: Removed LNI 192.168.202.24@tcp [11380.961049] Key type .llcrypt unregistered [11380.962242] Key type ._llcrypt unregistered [11384.681070] Key type ._llcrypt registered [11384.684886] Key type .llcrypt registered [11384.845362] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11384.850908] alg: No test for adler32 (adler32-zlib) [11385.708884] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [11385.801208] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [11387.384174] Key type lgssc registered [11387.768030] Lustre: Echo OBD driver; http://www.lustre.org/ [11409.671626] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11411.465908] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11419.225566] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11499.762701] LNet: Added LNI 192.168.202.24@tcp50 [8/256/0/180] [11500.475427] LNet: Removed LNI 192.168.202.24@tcp [11501.869274] Lustre: 301451:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8dbf10f89000: config has no valid NIDs, force dynamic NIDs [11502.909980] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [11502.961110] Lustre: Unmounted lustre-client [11503.851639] Key type lgssc unregistered [11503.988710] LNet: 301713:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11503.990918] LNetError: 301713:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11503.997296] LNet: Removed LNI 192.168.202.24@tcp50 [11504.187141] Key type .llcrypt unregistered [11504.188403] Key type ._llcrypt unregistered [11514.025879] Key type ._llcrypt registered [11514.026937] Key type .llcrypt registered [11514.217855] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11514.222223] alg: No test for adler32 (adler32-zlib) [11515.078244] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [11515.163271] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [11516.744139] Key type lgssc registered [11517.094514] Lustre: Echo OBD driver; http://www.lustre.org/ [11530.107178] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11531.759826] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11533.997241] LNet: Added LNI 192.168.202.24@tcp50 [8/256/0/180] [11534.254354] LNet: Removed LNI 192.168.202.24@tcp [11535.341027] Lustre: 304395:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8dbf06518800: config has no valid NIDs, force dynamic NIDs [11536.384062] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [11536.543140] Lustre: Unmounted lustre-client [11554.940686] Key type lgssc unregistered [11555.077636] LNet: 305267:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11555.079723] LNetError: 305267:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11555.088632] LNet: Removed LNI 192.168.202.24@tcp50 [11555.303778] Key type .llcrypt unregistered [11555.305154] Key type ._llcrypt unregistered [11558.865549] Key type ._llcrypt registered [11558.866733] Key type .llcrypt registered [11559.303917] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 17:02:08 (1787086928) [11564.712487] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11564.755032] alg: No test for adler32 (adler32-zlib) [11565.599259] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [11565.690132] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [11567.280212] Key type lgssc registered [11567.725947] Lustre: Echo OBD driver; http://www.lustre.org/ [11595.591343] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11597.303809] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11605.025509] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11623.551696] Key type lgssc unregistered [11623.676597] LNet: 310000:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11623.679489] LNetError: 310000:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11623.688500] LNet: Removed LNI 192.168.202.24@tcp [11623.936978] Key type .llcrypt unregistered [11623.938352] Key type ._llcrypt unregistered [11627.503355] Key type ._llcrypt registered [11627.504437] Key type .llcrypt registered [11627.966832] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 17:03:16 (1787086996) [11628.690985] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11628.699357] alg: No test for adler32 (adler32-zlib) [11629.564395] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [11629.655444] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [11631.240166] Key type lgssc registered [11631.661321] Lustre: Echo OBD driver; http://www.lustre.org/ [11648.630739] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11650.261062] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11656.285902] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11666.930538] Lustre: Mounted lustre-client - version 2.17.57_1_g711d631 [11686.009401] Lustre: Mounted fs15246-client - version 2.17.57_1_g711d631 [11690.411051] Lustre: Unmounted fs15246-client [11702.514137] Lustre: Unmounted lustre-client [11727.677137] Key type lgssc unregistered [11727.793527] LNet: 314852:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11727.795765] LNetError: 314852:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11727.802511] LNet: Removed LNI 192.168.202.24@tcp [11728.026129] Key type .llcrypt unregistered [11728.027429] Key type ._llcrypt unregistered [11731.526406] Key type ._llcrypt registered [11731.527878] Key type .llcrypt registered [11731.957065] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 17:05:00 (1787087100) [11732.506146] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11732.521117] alg: No test for adler32 (adler32-zlib) [11733.371755] Lustre: Lustre: Build Version: 2.17.57_1_g711d631 [11733.460797] LNet: Added LNI 192.168.202.24@tcp [8/256/0/180] [11735.040158] Key type lgssc registered [11735.377875] Lustre: Echo OBD driver; http://www.lustre.org/ [11777.524772] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11779.261813] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11786.673188] Lustre: DEBUG MARKER: oleg224-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11833.749312] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 11559 sec ========= 17:06:42 (1787087202) [11834.250424] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 17:06:43 (1787087203) === [11835.361943] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 17:06:44 (1787087204) === [11845.762711] Key type lgssc unregistered [11845.873493] LNet: 324085:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11845.876272] LNetError: 324085:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11845.883483] LNet: Removed LNI 192.168.202.24@tcp [11846.109640] Key type .llcrypt unregistered [11846.110534] Key type ._llcrypt unregistered