[ 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 458493462 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.003254] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.008912] ..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.009019] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010011] pid_max: default: 32768 minimum: 301 [ 0.011123] LSM: Security Framework initializing [ 0.012055] Yama: becoming mindful. [ 0.013110] SELinux: Initializing. [ 0.014065] *** VALIDATE selinux *** [ 0.021727] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026199] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027134] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029047] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030102] *** VALIDATE tmpfs *** [ 0.031413] *** VALIDATE proc *** [ 0.032228] *** VALIDATE cgroup *** [ 0.033011] *** VALIDATE cgroup2 *** [ 0.035254] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036154] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038030] Spectre V2 : User space: Vulnerable [ 0.039010] Speculative Store Bypass: Vulnerable [ 0.042244] debug: unmapping init [mem 0xffffffff98859000-0xffffffff98860fff] [ 0.044950] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.045690] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.046024] ... version: 2 [ 0.047015] ... bit width: 48 [ 0.048017] ... generic registers: 4 [ 0.049016] ... value mask: 0000ffffffffffff [ 0.050018] ... max period: 00007fffffffffff [ 0.051024] ... fixed-purpose events: 3 [ 0.052016] ... event mask: 000000070000000f [ 0.053293] rcu: Hierarchical SRCU implementation. [ 0.055324] smp: Bringing up secondary CPUs ... [ 0.056569] x86: Booting SMP configuration: [ 0.057028] .... node #0, CPUs: #1 #2 #3 [ 0.060236] smp: Brought up 1 node, 4 CPUs [ 0.062017] smpboot: Max logical packages: 1 [ 0.063018] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.152019] node 0 deferred pages initialised in 86ms [ 0.155117] devtmpfs: initialized [ 0.156217] x86/mm: Memory block size: 128MB [ 0.158729] gcov: version magic: 0x41383552 [ 0.160125] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.161118] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.162221] pinctrl core: initialized pinctrl subsystem [ 0.163188] [ 0.163791] ************************************************************* [ 0.164018] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.165012] ** ** [ 0.166013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.167012] ** ** [ 0.168013] ** This means that this kernel is built to expose internal ** [ 0.169013] ** IOMMU data structures, which may compromise security on ** [ 0.170012] ** your system. ** [ 0.171015] ** ** [ 0.172012] ** If you see this message and you are not debugging the ** [ 0.173015] ** kernel, report this immediately to your vendor! ** [ 0.174014] ** ** [ 0.175016] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.176012] ************************************************************* [ 0.177672] NET: Registered protocol family 16 [ 0.178444] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.179066] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.180060] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.181431] cpuidle: using governor menu [ 0.183272] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.186534] PCI: Using configuration type 1 for base access [ 0.188120] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.198145] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.200018] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.204082] cryptd: max_cpu_qlen set to 1000 [ 0.207246] ACPI: Added _OSI(Module Device) [ 0.208014] ACPI: Added _OSI(Processor Device) [ 0.210011] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.211010] ACPI: Added _OSI(Processor Aggregator Device) [ 0.216176] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.222537] ACPI: Interpreter enabled [ 0.224059] ACPI: PM: (supports S0 S3 S4 S5) [ 0.225011] ACPI: Using IOAPIC for interrupt routing [ 0.227090] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.230383] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.240474] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.243036] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.245025] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.249075] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.254316] acpiphp: Slot [2] registered [ 0.256122] acpiphp: Slot [5] registered [ 0.257094] acpiphp: Slot [6] registered [ 0.259129] acpiphp: Slot [3] registered [ 0.260124] acpiphp: Slot [4] registered [ 0.262104] acpiphp: Slot [7] registered [ 0.263101] acpiphp: Slot [8] registered [ 0.265089] acpiphp: Slot [9] registered [ 0.266119] acpiphp: Slot [10] registered [ 0.268111] acpiphp: Slot [11] registered [ 0.269091] acpiphp: Slot [12] registered [ 0.270092] acpiphp: Slot [13] registered [ 0.272116] acpiphp: Slot [14] registered [ 0.274090] acpiphp: Slot [15] registered [ 0.275102] acpiphp: Slot [16] registered [ 0.276178] acpiphp: Slot [17] registered [ 0.278100] acpiphp: Slot [18] registered [ 0.280124] acpiphp: Slot [19] registered [ 0.281103] acpiphp: Slot [20] registered [ 0.283105] acpiphp: Slot [21] registered [ 0.284096] acpiphp: Slot [22] registered [ 0.286106] acpiphp: Slot [23] registered [ 0.287099] acpiphp: Slot [24] registered [ 0.289118] acpiphp: Slot [25] registered [ 0.290108] acpiphp: Slot [26] registered [ 0.292169] acpiphp: Slot [27] registered [ 0.294113] acpiphp: Slot [28] registered [ 0.295114] acpiphp: Slot [29] registered [ 0.297098] acpiphp: Slot [30] registered [ 0.298116] acpiphp: Slot [31] registered [ 0.300080] PCI host bridge to bus 0000:00 [ 0.301018] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.304040] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.307012] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.309024] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.312020] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.314021] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.316177] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.319066] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.322428] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.330015] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.335059] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.338023] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.340018] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.342014] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.344551] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.347814] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.350046] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.353855] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.358013] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.368015] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.372028] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.377934] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.385014] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.391014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.405015] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.415701] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.422014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.428017] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.441013] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.450511] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.452356] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.454315] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.457299] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.459171] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.464038] iommu: Default domain type: Passthrough [ 0.466376] SCSI subsystem initialized [ 0.467117] ACPI: bus type USB registered [ 0.469105] usbcore: registered new interface driver usbfs [ 0.470066] usbcore: registered new interface driver hub [ 0.472068] usbcore: registered new device driver usb [ 0.473136] pps_core: LinuxPPS API ver. 1 registered [ 0.475010] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.479072] PTP clock support registered [ 0.482040] EDAC MC: Ver: 3.0.0 [ 0.484444] PCI: Using ACPI for IRQ routing [ 0.486615] NetLabel: Initializing [ 0.488009] NetLabel: domain hash size = 128 [ 0.489009] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.492077] NetLabel: unlabeled traffic allowed by default [ 0.494251] vgaarb: loaded [ 0.496232] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.498014] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.504277] clocksource: Switched to clocksource kvm-clock [ 0.599722] VFS: Disk quotas dquot_6.6.0 [ 0.601375] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.603891] *** VALIDATE ramfs *** [ 0.605141] *** VALIDATE hugetlbfs *** [ 0.607016] pnp: PnP ACPI init [ 0.610386] pnp: PnP ACPI: found 6 devices [ 0.630082] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.633690] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.637077] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.639985] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.643670] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.647352] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.651521] NET: Registered protocol family 2 [ 0.654660] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.660663] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.664548] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.670684] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.674284] TCP: Hash tables configured (established 65536 bind 65536) [ 0.677271] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.680296] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.683111] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.686166] NET: Registered protocol family 1 [ 0.689464] RPC: Registered named UNIX socket transport module. [ 0.691793] RPC: Registered udp transport module. [ 0.693483] RPC: Registered tcp transport module. [ 0.695289] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.697812] NET: Registered protocol family 44 [ 0.699676] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.703076] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.705349] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.707819] PCI: CLS 0 bytes, default 64 [ 0.709543] Unpacking initramfs... [ 2.111681] debug: unmapping init [mem 0xffff9ff1fcc64000-0xffff9ff1fffcffff] [ 2.115968] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.118934] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.121910] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.610760] Initialise system trusted keyrings [ 2.612711] Key type blacklist registered [ 2.614522] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.623655] zbud: loaded [ 2.626379] *** VALIDATE nfs *** [ 2.627645] *** VALIDATE nfs4 *** [ 2.629169] pstore: using deflate compression [ 2.633427] Platform Keyring initialized [ 2.732549] NET: Registered protocol family 38 [ 2.734381] Key type asymmetric registered [ 2.735850] Asymmetric key parser 'x509' registered [ 2.737634] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.740295] io scheduler mq-deadline registered [ 2.741860] io scheduler kyber registered [ 2.743222] io scheduler bfq registered [ 2.745865] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.749297] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.752495] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.755461] ACPI: Power Button [PWRF] [ 2.760605] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.768454] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.783885] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.810731] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.839541] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.843720] Non-volatile memory driver v1.3 [ 2.845285] Linux agpgart interface v0.103 [ 2.874479] virtio_blk virtio1: [vda] 146864 512-byte logical blocks (75.2 MB/71.7 MiB) [ 2.877183] vda: detected capacity change from 0 to 75194368 [ 2.890286] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.894928] vdb: detected capacity change from 0 to 1073741824 [ 2.901705] libphy: Fixed MDIO Bus: probed [ 2.907894] usbcore: registered new interface driver usbserial_generic [ 2.910257] usbserial: USB Serial support registered for generic [ 2.915416] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.919683] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.921406] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.923600] mousedev: PS/2 mouse device common for all mice [ 2.926497] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.928934] rtc_cmos 00:05: RTC can wake from S4 [ 2.935546] rtc_cmos 00:05: registered as rtc0 [ 2.936502] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.937661] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.944570] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.944689] intel_pstate: CPU model not supported [ 2.951518] hid: raw HID events driver (C) Jiri Kosina [ 2.954030] usbcore: registered new interface driver usbhid [ 2.956326] usbhid: USB HID core driver [ 2.958992] drop_monitor: Initializing network drop monitor service [ 2.961898] Initializing XFRM netlink socket [ 2.964258] NET: Registered protocol family 10 [ 2.967641] Segment Routing with IPv6 [ 2.969349] NET: Registered protocol family 17 [ 2.971388] mpls_gso: MPLS GSO support [ 2.977498] RAS: Correctable Errors collector initialized. [ 2.979902] AVX version of gcm_enc/dec engaged. [ 2.981505] AES CTR mode by8 optimization enabled [ 3.059592] sched_clock: Marking stable (3059550407, 0)->(3993075469, -933525062) [ 3.066204] registered taskstats version 1 [ 3.068298] Loading compiled-in X.509 certificates [ 3.070504] zswap: loaded using pool lzo/zbud [ 3.097720] Key type big_key registered [ 3.111327] Key type encrypted registered [ 3.113033] ima: No TPM chip found, activating TPM-bypass! [ 3.115324] ima: Allocated hash algorithm: sha1 [ 3.117163] ima: No architecture policies found [ 3.119048] evm: Initialising EVM extended attributes: [ 3.121114] evm: security.selinux [ 3.122584] evm: security.ima [ 3.123817] evm: security.capability [ 3.125388] evm: HMAC attrs: 0x1 [ 3.127934] rtc_cmos 00:05: setting system clock to 2026-08-27 18:08:10 UTC (1787854090) [ 3.135307] debug: unmapping init [mem 0xffffffff99803000-0xffffffff999fffff] [ 3.137800] debug: unmapping init [mem 0xffffffff98582000-0xffffffff98858fff] [ 3.147104] Write protecting the kernel read-only data: 28672k [ 3.150742] debug: unmapping init [mem 0xffffffff96c03000-0xffffffff96dfffff] [ 3.153905] debug: unmapping init [mem 0xffffffff97514000-0xffffffff975fffff] [ 3.192914] 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.201739] systemd[1]: Detected virtualization kvm. [ 3.203730] systemd[1]: Detected architecture x86-64. [ 3.206078] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.235849] systemd[1]: No hostname configured. [ 3.238274] systemd[1]: Set hostname to . [ 3.240338] random: systemd: uninitialized urandom read (16 bytes read) [ 3.242717] systemd[1]: Initializing machine ID from random generator. [ 3.295842] random: ln: uninitialized urandom read (6 bytes read) [ 3.391154] random: systemd: uninitialized urandom read (16 bytes read) [ 3.393959] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.398343] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 3.403871] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Local Encrypted Volumes. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Paths. Starting Apply Kernel Variables... [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. Starting Setup Virtual Console... [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.062738] device-mapper: uevent: version 1.0.3 [ 4.064992] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.844377] virtio_net virtio0 ens2: renamed from eth0 [ 4.857545] random: fast init done [ 4.909309] scsi host0: ata_piix [ 4.976391] scsi host1: ata_piix [ 4.978206] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.980859] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.695606] dracut-initqueue[582]: RTNETLINK answers: File exists [ 9.631219] random: crng init done [ 9.633419] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.124306] 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. [ 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. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local File Systems. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev 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.349922] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.620580] SELinux: Disabled at runtime. [ 11.681450] 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.690520] systemd[1]: Detected virtualization kvm. [ 11.692684] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.297327] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.301090] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.308309] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.311950] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.314984] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.323869] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.333748] systemd[1]: Mounting Huge Pages File System... Mounting Huge Pages File System... [ OK ] Listening on udev Control Socket. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting Kernel Debug File System... [ OK ] Listening on Process Core Dump Socket. [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Forward Password Requests to Wall Directory Watch. Activating swap /dev/disk/by-label/SWAP... [ 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. Starting Apply Kernel Variables... Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. [ 12.431828] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Created slice system-getty.slice. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... Mounting POSIX Message Queue File System... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.834936] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.204914] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.206284] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.318766] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.339200] EDAC sbridge: Ver: 1.1.2 [ 14.569220] Key type dns_resolver registered [ 14.879895] NFS: Registering the id_resolver key type [ 14.882202] Key type id_resolver registered [ 14.884092] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. [ OK ] Started D-Bus System Message Bus. Starting Login Service... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Restore /run/initramfs on shutdown... Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... Starting System Logging Service... [ 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 oleg629-client login: [ 57.855812] libcfs: loading out-of-tree module taints kernel. [ 58.306322] Key type ._llcrypt registered [ 58.308543] Key type .llcrypt registered [ 58.844952] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 58.858549] alg: No test for adler32 (adler32-zlib) [ 60.531799] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 61.747734] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 63.569077] Key type lgssc registered [ 65.247584] Lustre: Echo OBD driver; http://www.lustre.org/ [ 239.853844] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 245.412264] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 262.792838] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing check_logdir /tmp/testlogs/ [ 265.697420] Lustre: lustre-OST0000-osc-ffff9ff251d47800: disconnect after 24s idle [ 268.843951] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing yml_node [ 273.861322] Lustre: DEBUG MARKER: Client: 2.17.57.83 [ 276.183331] Lustre: DEBUG MARKER: MDS: 2.17.57.83 [ 278.495609] Lustre: DEBUG MARKER: OSS: 2.17.57.83 [ 280.125586] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Aug 27 14:12:46 EDT 2026 [ 296.446710] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 298.126148] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 301.150670] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 311.513393] Lustre: Unmounted lustre-client [ 413.768832] hrtimer: interrupt took 5684297 ns [ 418.895277] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 424.692494] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 446.813865] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 489.851509] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 14:16:15 (1787854575) [ 491.992230] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 493.765333] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 14:16:19 (1787854579) [ 525.353493] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 530.011970] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 548.494853] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 549.201118] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 553.980511] Lustre: Unmounted lustre-client [ 580.401980] Key type lgssc unregistered [ 580.700249] LNet: 15053:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 580.723604] LNetError: 15053:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 580.752976] LNet: Removed LNI 192.168.206.29@tcp [ 581.674136] Key type .llcrypt unregistered [ 581.677931] Key type ._llcrypt unregistered [ 596.961815] Key type ._llcrypt registered [ 596.965381] Key type .llcrypt registered [ 598.054591] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 14:18:04 (1787854684) [ 600.161495] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 600.178456] alg: No test for adler32 (adler32-zlib) [ 601.275428] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 601.683127] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 603.506465] Key type lgssc registered [ 604.851447] Lustre: Echo OBD driver; http://www.lustre.org/ [ 679.572466] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 763.600103] Lustre: Unmounted lustre-client [ 789.071728] Key type lgssc unregistered [ 789.326346] LNet: 18849:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 789.338951] LNetError: 18849:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 789.361562] LNet: Removed LNI 192.168.206.29@tcp [ 789.925981] Key type .llcrypt unregistered [ 789.928712] Key type ._llcrypt unregistered [ 798.573739] Key type ._llcrypt registered [ 798.575990] Key type .llcrypt registered [ 799.674858] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 14:21:25 (1787854885) [ 801.761278] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 801.786551] alg: No test for adler32 (adler32-zlib) [ 802.917056] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 803.124356] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 804.784338] Key type lgssc registered [ 806.152140] Lustre: Echo OBD driver; http://www.lustre.org/ [ 853.531708] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 859.244879] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 877.672640] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 880.518547] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 899.102586] Lustre: Unmounted lustre-client [ 924.976603] Key type lgssc unregistered [ 925.178672] LNet: 22452:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 925.189098] LNetError: 22452:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 925.205143] LNet: Removed LNI 192.168.206.29@tcp [ 925.869973] Key type .llcrypt unregistered [ 925.880379] Key type ._llcrypt unregistered [ 934.122799] Key type ._llcrypt registered [ 934.125122] Key type .llcrypt registered [ 935.219311] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 14:23:41 (1787855021) [ 936.794520] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 936.818614] alg: No test for adler32 (adler32-zlib) [ 937.872128] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 938.084240] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 939.736218] Key type lgssc registered [ 940.796666] Lustre: Echo OBD driver; http://www.lustre.org/ [ 990.575497] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 997.922762] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1018.490427] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1021.343517] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 1030.601075] Lustre: Unmounted lustre-client [ 1059.925991] Key type lgssc unregistered [ 1060.251165] LNet: 25642:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1060.267175] LNetError: 25642:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1060.300322] LNet: Removed LNI 192.168.206.29@tcp [ 1061.096148] Key type .llcrypt unregistered [ 1061.098695] Key type ._llcrypt unregistered [ 1075.254276] Key type ._llcrypt registered [ 1075.258354] Key type .llcrypt registered [ 1076.390880] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 14:26:02 (1787855162) [ 1078.993670] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1079.022088] alg: No test for adler32 (adler32-zlib) [ 1080.118551] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 1080.418335] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 1082.129095] Key type lgssc registered [ 1083.471891] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1131.583368] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1136.743079] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1155.658921] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1158.314620] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 1163.252556] Lustre: lustre-MDT0000-mdc-ffff9ff251ab9000: Connection to lustre-MDT0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1168.364111] Lustre: lustre-MDT0001-mdc-ffff9ff251ab9000: Connection to lustre-MDT0001 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1176.041170] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1179.617106] Lustre: 26601:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787855250/real 1787855250] req@000000004d70aceb x1874702019597184/t0(0) o400->MGC192.168.206.129@tcp@192.168.206.129@tcp:26/25 lens 224/224 e 0 to 1 dl 1787855266 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1179.632462] LustreError: MGC192.168.206.129@tcp: Connection to MGS (at 192.168.206.129@tcp) was lost; in progress operations using this service will fail [ 1186.394678] Lustre: Unmounted lustre-client [ 1203.269499] Key type lgssc unregistered [ 1203.506518] LNet: 29299:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1203.521323] LNetError: 29299:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1203.575252] LNet: Removed LNI 192.168.206.29@tcp [ 1204.234527] Key type .llcrypt unregistered [ 1204.237842] Key type ._llcrypt unregistered [ 1216.796458] Key type ._llcrypt registered [ 1216.799702] Key type .llcrypt registered [ 1218.353701] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 14:28:24 (1787855304) [ 1221.109070] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1221.157698] alg: No test for adler32 (adler32-zlib) [ 1222.346960] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 1222.614991] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 1224.278381] Key type lgssc registered [ 1225.483515] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1272.051194] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1278.626609] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1297.620254] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1300.351494] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 1311.996477] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1322.356190] Lustre: Unmounted lustre-client [ 1349.870393] Key type lgssc unregistered [ 1350.211491] LNet: 32923:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1350.218151] LNetError: 32923:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1350.239959] LNet: Removed LNI 192.168.206.29@tcp [ 1350.954606] Key type .llcrypt unregistered [ 1350.966118] Key type ._llcrypt unregistered [ 1367.970879] Key type ._llcrypt registered [ 1367.972719] Key type .llcrypt registered [ 1369.173468] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 14:30:55 (1787855455) [ 1371.115705] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1371.151467] alg: No test for adler32 (adler32-zlib) [ 1372.191744] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 1372.396953] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 1374.081475] Key type lgssc registered [ 1375.059170] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1422.743952] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1428.119908] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1449.941652] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1452.730142] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 1459.550831] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1462.893932] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1475.008636] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-2714h32m40s [ 1477.119440] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1483.764052] Lustre: lustre-MDT0000-mdc-ffff9ff24455c000: Connection to lustre-MDT0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1488.863168] LustreError: 36711:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff9ff24455c000: can't stat MDS #0: rc = -19 [ 1490.395825] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1502.190856] LustreError: MGC192.168.206.129@tcp: Connection to MGS (at 192.168.206.129@tcp) was lost; in progress operations using this service will fail [ 1502.223105] Lustre: Evicted from MGS (at 192.168.206.129@tcp) after server handle changed from 0x146102b1b1f29e2 to 0x146102b1b1f2cac [ 1502.240265] Lustre: MGC192.168.206.129@tcp: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 1503.271675] LustreError: lustre-MDT0000-mdc-ffff9ff24455c000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1503.312031] Lustre: lustre-MDT0000-mdc-ffff9ff24455c000: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 1506.270774] Lustre: DEBUG MARKER: Wait for df (36711) ... [ 1507.747779] Lustre: DEBUG MARKER: done [ 1509.882685] Lustre: Unmounted lustre-client [ 1545.865736] Key type lgssc unregistered [ 1546.104083] LNet: 37730:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1546.108417] LNetError: 37730:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1546.136583] LNet: Removed LNI 192.168.206.29@tcp [ 1546.922907] Key type .llcrypt unregistered [ 1546.926402] Key type ._llcrypt unregistered [ 1579.842903] Key type ._llcrypt registered [ 1579.846228] Key type .llcrypt registered [ 1581.071371] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 14:34:27 (1787855667) [ 1583.892689] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1583.915159] alg: No test for adler32 (adler32-zlib) [ 1584.983503] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 1585.226299] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 1586.928230] Key type lgssc registered [ 1588.121985] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1639.018631] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1645.796422] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1668.320745] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1670.916331] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 1675.618678] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-2714h36m01s [ 1677.454299] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1684.956507] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1687.811188] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1708.000142] Lustre: 41874:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787855775/real 1787855775] req@000000001b7c1357 x1874702549129984/t0(0) o101->lustre-MDT0000-mdc-ffff9ff253aa7000@192.168.206.129@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787855795 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1708.035556] Lustre: lustre-MDT0000-mdc-ffff9ff253aa7000: Connection to lustre-MDT0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1708.066766] Lustre: lustre-MDT0000-mdc-ffff9ff253aa7000: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 1729.786684] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1732.636634] Lustre: DEBUG MARKER: done [ 1736.875893] Lustre: Unmounted lustre-client [ 1762.993804] Key type lgssc unregistered [ 1763.353561] LNet: 42762:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1763.366153] LNetError: 42762:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1763.406831] LNet: Removed LNI 192.168.206.29@tcp [ 1764.357255] Key type .llcrypt unregistered [ 1764.363470] Key type ._llcrypt unregistered [ 1796.068460] Key type ._llcrypt registered [ 1796.070540] Key type .llcrypt registered [ 1797.570052] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 14:38:03 (1787855883) [ 1799.298369] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1800.915702] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 14:38:06 (1787855886) [ 1804.617062] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1804.730735] alg: No test for adler32 (adler32-zlib) [ 1805.860460] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 1806.062751] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 1807.744279] Key type lgssc registered [ 1808.997530] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1836.200172] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 14:38:42 (1787855922) [ 1866.028037] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1870.896983] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1888.663429] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1891.716612] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 1896.182270] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1900.417531] Lustre: Unmounted lustre-client [ 1924.799352] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1974.691416] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1980.216291] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1980.814414] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 1985.034027] Lustre: Unmounted lustre-client [ 2045.919604] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2052.024646] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2052.798291] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 2057.133203] Lustre: Unmounted lustre-client [ 2077.869762] Lustre: DEBUG MARKER: files compared the same [ 2100.231783] Key type lgssc unregistered [ 2100.490009] LNet: 50385:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2100.497546] LNetError: 50385:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2100.536252] LNet: Removed LNI 192.168.206.29@tcp [ 2101.048135] Key type .llcrypt unregistered [ 2101.052724] Key type ._llcrypt unregistered [ 2117.374366] Key type ._llcrypt registered [ 2117.378298] Key type .llcrypt registered [ 2119.043931] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 14:43:24 (1787856204) [ 2121.591618] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2121.683086] alg: No test for adler32 (adler32-zlib) [ 2122.810725] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 2123.177668] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 2125.040762] Key type lgssc registered [ 2126.781761] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2180.007165] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2185.307136] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2205.211111] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2207.040066] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 2211.065881] Lustre: Unmounted lustre-client [ 2238.593527] Key type lgssc unregistered [ 2238.875990] LNet: 53972:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2238.894758] LNetError: 53972:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2238.915864] LNet: Removed LNI 192.168.206.29@tcp [ 2239.686446] Key type .llcrypt unregistered [ 2239.690400] Key type ._llcrypt unregistered [ 2255.469960] Key type ._llcrypt registered [ 2255.474744] Key type .llcrypt registered [ 2256.998574] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 14:45:42 (1787856342) [ 2259.469154] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2259.504883] alg: No test for adler32 (adler32-zlib) [ 2260.562993] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 2260.797290] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 2262.448156] Key type lgssc registered [ 2263.633322] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2345.278982] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2378.565847] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2383.823507] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2421.070825] Key type lgssc unregistered [ 2421.355271] LNet: 57460:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2421.361567] LNetError: 57460:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2421.373637] LNet: Removed LNI 192.168.206.29@tcp [ 2422.016271] Key type .llcrypt unregistered [ 2422.019330] Key type ._llcrypt unregistered [ 2442.766227] Key type ._llcrypt registered [ 2442.768348] Key type .llcrypt registered [ 2444.226671] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 14:48:50 (1787856530) [ 2447.208524] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2447.297358] alg: No test for adler32 (adler32-zlib) [ 2448.406512] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 2448.751189] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 2450.464923] Key type lgssc registered [ 2451.687171] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2524.803060] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 2531.541247] Lustre: Unmounted lustre-client [ 2571.202293] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 14:50:56 (1787856656) [ 2689.315414] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2711.601872] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 2718.780303] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2718.792723] LustreError: 63937:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff9ff246dea800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2718.817790] Lustre: 58447:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.129@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2729.128891] Lustre: Unmounted lustre-client [ 2772.776808] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 14:54:18 (1787856858) [ 2785.813322] Key type lgssc unregistered [ 2786.154119] LNet: 65152:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2786.164664] LNetError: 65152:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2786.194273] LNet: Removed LNI 192.168.206.29@tcp [ 2786.854500] Key type .llcrypt unregistered [ 2786.861891] Key type ._llcrypt unregistered [ 2798.831207] Key type ._llcrypt registered [ 2798.833269] Key type .llcrypt registered [ 2798.985342] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2798.998782] alg: No test for adler32 (adler32-zlib) [ 2800.087465] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 2800.321237] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 2802.016314] Key type lgssc registered [ 2803.220542] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2850.039073] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2855.304713] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2876.287767] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2878.976322] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 2882.259451] Lustre: Unmounted lustre-client [ 2906.376919] Key type lgssc unregistered [ 2906.675891] LNet: 68165:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2906.683528] LNetError: 68165:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2906.698524] LNet: Removed LNI 192.168.206.29@tcp [ 2907.428814] Key type .llcrypt unregistered [ 2907.431521] Key type ._llcrypt unregistered [ 2916.734709] Key type ._llcrypt registered [ 2916.777690] Key type .llcrypt registered [ 2917.102422] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2917.111842] alg: No test for adler32 (adler32-zlib) [ 2918.168414] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 2918.424953] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 2920.144792] Key type lgssc registered [ 2921.378205] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3026.776774] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3032.605687] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3053.217644] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3054.930903] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 3057.028452] Lustre: Unmounted lustre-client [ 3083.416650] Key type lgssc unregistered [ 3083.640165] LNet: 71594:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3083.650835] LNetError: 71594:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3083.670174] LNet: Removed LNI 192.168.206.29@tcp [ 3084.313086] Key type .llcrypt unregistered [ 3084.317396] Key type ._llcrypt unregistered [ 3099.179348] Key type ._llcrypt registered [ 3099.182387] Key type .llcrypt registered [ 3100.349318] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 14:59:46 (1787857186) [ 3102.654568] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3102.680097] alg: No test for adler32 (adler32-zlib) [ 3103.760660] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 3104.029929] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 3105.712242] Key type lgssc registered [ 3106.745653] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3154.731402] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3159.664586] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3177.344314] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3179.816578] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 3184.205456] Lustre: Unmounted lustre-client [ 3184.492525] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 3186.869337] Lustre: Unmounted lustre-client [ 3211.700483] Key type lgssc unregistered [ 3211.965655] LNet: 75297:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3211.981776] LNetError: 75297:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3211.994085] LNet: Removed LNI 192.168.206.29@tcp [ 3212.732078] Key type .llcrypt unregistered [ 3212.736799] Key type ._llcrypt unregistered [ 3224.162384] Key type ._llcrypt registered [ 3224.167615] Key type .llcrypt registered [ 3224.782259] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3224.795123] alg: No test for adler32 (adler32-zlib) [ 3226.106433] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 3226.408066] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 3228.109136] Key type lgssc registered [ 3229.417463] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3277.046413] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3282.590185] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3305.020758] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3306.878900] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 3311.322449] Lustre: Unmounted lustre-client [ 3340.644747] Key type lgssc unregistered [ 3340.885740] LNet: 78334:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3340.897138] LNetError: 78334:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3340.914521] LNet: Removed LNI 192.168.206.29@tcp [ 3341.564708] Key type .llcrypt unregistered [ 3341.567550] Key type ._llcrypt unregistered [ 3355.948987] Key type ._llcrypt registered [ 3355.950787] Key type .llcrypt registered [ 3357.314351] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 15:04:03 (1787857443) [ 3359.682289] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3359.699834] alg: No test for adler32 (adler32-zlib) [ 3360.707722] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 3360.965817] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 3362.656595] Key type lgssc registered [ 3364.047268] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3410.760215] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3416.153563] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3436.290508] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3438.884655] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 3447.812650] Lustre: lustre: root_squash is set to 0:0 [ 3455.041934] Lustre: lustre: nosquash_nids is cleared [ 3455.072571] Lustre: lustre: root_squash is set to 500:500 [ 3460.383781] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.29@tcp 192.168.0.[2,10]@tcp [ 3475.485283] Lustre: lustre: nosquash_nids set to 192.168.206.29/24@tcp [ 3478.450653] Lustre: Unmounted lustre-client [ 3505.250670] Key type lgssc unregistered [ 3505.551412] LNet: 82287:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3505.567506] LNetError: 82287:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3505.582499] LNet: Removed LNI 192.168.206.29@tcp [ 3506.383947] Key type .llcrypt unregistered [ 3506.386094] Key type ._llcrypt unregistered [ 3525.379482] Key type ._llcrypt registered [ 3525.383335] Key type .llcrypt registered [ 3527.002853] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 15:06:52 (1787857612) [ 3529.129664] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3531.208140] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 15:06:56 (1787857616) [ 3533.384312] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3533.502756] alg: No test for adler32 (adler32-zlib) [ 3534.711722] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 3535.019576] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 3536.728311] Key type lgssc registered [ 3538.231670] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3587.470846] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3593.019647] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3615.148853] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3615.774547] Lustre: lustre: root_squash is set to 500:500 [ 3615.819394] Lustre: lustre: nosquash_nids set to 192.168.206.29/24@tcp [ 3616.895668] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 3622.581766] Lustre: Unmounted lustre-client [ 3649.731906] Key type lgssc unregistered [ 3649.949207] LNet: 86248:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3649.963209] LNetError: 86248:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3649.984712] LNet: Removed LNI 192.168.206.29@tcp [ 3650.732860] Key type .llcrypt unregistered [ 3650.737711] Key type ._llcrypt unregistered [ 3665.167749] Key type ._llcrypt registered [ 3665.170958] Key type .llcrypt registered [ 3666.550257] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3668.121142] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 15:09:14 (1787857754) [ 3685.974593] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3685.988168] alg: No test for adler32 (adler32-zlib) [ 3687.064431] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 3687.344919] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 3689.048371] Key type lgssc registered [ 3690.346707] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3766.633415] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3770.862581] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3790.668508] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3862.411243] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3868.083589] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3891.356910] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3904.215741] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 3939.180929] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9ff245b03000.ost_server_uuid 50 [ 3940.518543] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9ff245b03000.ost_server_uuid in FULL state after 0 sec [ 3941.165617] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 3944.870312] Lustre: Unmounted lustre-client [ 3948.175425] Lustre: Unmounted lustre-client [ 3995.015721] Key type lgssc unregistered [ 3995.256748] LNet: 93911:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3995.265696] LNetError: 93911:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3995.285914] LNet: Removed LNI 192.168.206.29@tcp [ 3996.026588] Key type .llcrypt unregistered [ 3996.031498] Key type ._llcrypt unregistered [ 4022.823501] Key type ._llcrypt registered [ 4022.827629] Key type .llcrypt registered [ 4023.981619] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 15:15:10 (1787858110) [ 4040.136347] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4040.178145] alg: No test for adler32 (adler32-zlib) [ 4041.241737] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 4041.488597] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 4043.200283] Key type lgssc registered [ 4044.366729] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4121.196947] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4125.964090] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4149.285271] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4150.959167] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 4171.744187] Lustre: 95269:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787858243/real 1787858243] req@0000000083f20809 x1874705124430976/t0(0) o400->lustre-OST0000-osc-ffff9ff246de9000@192.168.206.129@tcp:28/4 lens 224/224 e 0 to 1 dl 1787858259 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4171.777598] Lustre: lustre-OST0000-osc-ffff9ff246de9000: Connection to lustre-OST0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4176.864699] Lustre: 95270:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787858248/real 1787858248] req@000000004f6ca241 x1874705124431488/t0(0) o400->lustre-OST0000-osc-ffff9ff246de9000@192.168.206.129@tcp:28/4 lens 224/224 e 0 to 1 dl 1787858264 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4182.093143] Lustre: lustre-OST0000-osc-ffff9ff246de9000: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 4183.136188] Lustre: 95270:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787858253/real 1787858254] req@00000000fb67dc45 x1874705124432000/t0(0) o400->lustre-OST0000-osc-ffff9ff246de9000@192.168.206.129@tcp:28/4 lens 224/224 e 0 to 1 dl 1787858269 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4187.123711] Lustre: lustre-MDT0000-mdc-ffff9ff246de9000: Connection to lustre-MDT0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4188.128592] Lustre: 95270:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787858259/real 1787858259] req@0000000070cf49dc x1874705124432512/t0(0) o400->lustre-OST0000-osc-ffff9ff246de9000@192.168.206.129@tcp:28/4 lens 224/224 e 0 to 1 dl 1787858275 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4203.361683] Lustre: 95271:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787858274/real 1787858274] req@00000000d8cc3356 x1874705124434432/t0(0) o400->MGC192.168.206.129@tcp@192.168.206.129@tcp:26/25 lens 224/224 e 0 to 1 dl 1787858290 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4203.384379] LustreError: MGC192.168.206.129@tcp: Connection to MGS (at 192.168.206.129@tcp) was lost; in progress operations using this service will fail [ 4213.549726] Lustre: Evicted from MGS (at 192.168.206.129@tcp) after server handle changed from 0x4c48fdff965993d6 to 0x4c48fdff96599668 [ 4213.567303] Lustre: MGC192.168.206.129@tcp: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 4218.448410] Lustre: lustre-MDT0000-mdc-ffff9ff246de9000: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 4223.219464] Lustre: Unmounted lustre-client [ 4266.013560] Key type lgssc unregistered [ 4266.249752] LNet: 99579:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4266.264872] LNetError: 99579:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4267.303911] LNet: Removed LNI 192.168.206.29@tcp [ 4268.005079] Key type .llcrypt unregistered [ 4268.014370] Key type ._llcrypt unregistered [ 4282.201227] Key type ._llcrypt registered [ 4282.203741] Key type .llcrypt registered [ 4283.436683] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 15:19:29 (1787858369) [ 4298.782491] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4298.811030] alg: No test for adler32 (adler32-zlib) [ 4299.913473] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 4300.133781] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 4301.800503] Key type lgssc registered [ 4302.768681] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4337.242655] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4446.503730] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4451.466486] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4472.333107] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4474.092910] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 4476.175687] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4478.378864] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 15:22:43 (1787858563) [ 4677.813481] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4688.142432] Lustre: Unmounted lustre-client [ 4803.146980] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4808.049627] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4830.241719] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4879.174903] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 15:29:25 (1787858965) [ 4964.111132] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4970.454543] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4993.943877] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4994.548780] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 4998.679191] Lustre: Unmounted lustre-client [ 5027.821900] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 15:31:53 (1787859113) [ 5119.050318] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5125.924132] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5155.036617] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5156.120823] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 5161.958917] Lustre: Unmounted lustre-client [ 5190.141864] Key type lgssc unregistered [ 5190.410704] LNet: 122596:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5190.417065] LNetError: 122596:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5190.436661] LNet: Removed LNI 192.168.206.29@tcp [ 5191.194135] Key type .llcrypt unregistered [ 5191.195943] Key type ._llcrypt unregistered [ 5208.523664] Key type ._llcrypt registered [ 5208.525796] Key type .llcrypt registered [ 5209.794884] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 15:34:55 (1787859295) [ 5212.406401] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5212.474842] alg: No test for adler32 (adler32-zlib) [ 5213.616678] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 5213.956816] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 5215.681671] Key type lgssc registered [ 5216.814534] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5264.941133] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5270.348771] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5289.927552] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5292.790229] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 5307.254834] Lustre: Unmounted lustre-client [ 5336.674487] Key type lgssc unregistered [ 5337.086874] LNet: 126197:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5337.097726] LNetError: 126197:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5337.126827] LNet: Removed LNI 192.168.206.29@tcp [ 5337.962759] Key type .llcrypt unregistered [ 5337.977042] Key type ._llcrypt unregistered [ 5357.167093] Key type ._llcrypt registered [ 5357.172552] Key type .llcrypt registered [ 5358.476396] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 15:37:24 (1787859444) [ 5360.655782] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5360.676390] alg: No test for adler32 (adler32-zlib) [ 5361.681888] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 5361.901877] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 5363.536348] Key type lgssc registered [ 5364.680823] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5411.194730] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5416.177225] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5438.724827] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5441.438280] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 5446.671250] Lustre: lustre-OST0000-osc-ffff9ff247fe6800: Connection to lustre-OST0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5458.326893] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff9ff247fe6800.ost_server_uuid 50 [ 5459.944241] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5471.053444] Lustre: Unmounted lustre-client [ 5495.255306] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 15:39:40 (1787859580) [ 5535.991157] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5542.399847] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5561.845198] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5582.750039] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5583.456310] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 5588.455992] Lustre: lustre-OST0000-osc-ffff9ff24698d000: Connection to lustre-OST0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5613.034537] Lustre: Unmounted lustre-client [ 5662.970146] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 15:42:28 (1787859748) [ 5693.202274] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5699.318551] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5721.960518] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5742.783474] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5743.325815] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 5748.712142] Lustre: lustre-OST0000-osc-ffff9ff251abe800: Connection to lustre-OST0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5764.997585] Lustre: Unmounted lustre-client [ 5820.927124] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 15:45:06 (1787859906) [ 5911.543462] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5917.160140] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5939.263784] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6013.294640] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6019.651777] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6039.296375] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6067.322285] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 6109.718842] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6114.241573] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 6115.964355] Lustre: Unmounted lustre-client [ 6145.501524] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 15:50:31 (1787860231) [ 6176.796859] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6184.185504] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6203.237742] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6233.446371] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6261.425970] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 6303.430068] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6305.108435] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6307.816180] Lustre: lustre-OST0001-osc-ffff9ff24698d800: Connection to lustre-OST0001 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6325.113660] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6335.488667] Lustre: Unmounted lustre-client [ 6394.421885] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 15:54:40 (1787860480) [ 6427.556680] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6434.177464] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6454.788252] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6455.338941] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 6475.765303] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6477.093520] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6492.022418] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff9ff247fe5800.ost_server_uuid 50 [ 6493.448716] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff9ff247fe5800.ost_server_uuid in IDLE state after 0 sec [ 6496.867792] Lustre: Unmounted lustre-client [ 6497.211249] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6497.216373] Lustre: Skipped 3 previous similar messages [ 6497.328212] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 6498.388059] LustreError: 149640:0:(sec.c:403:import_sec_validate_get()) import 00000000b49c3b89 (NEW) with no sec [ 6548.237934] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 15:57:14 (1787860634) [ 6580.418359] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6587.334851] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6610.848967] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6629.685944] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6630.203262] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6630.342512] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 6645.081975] Lustre: Unmounted lustre-client [ 6645.085199] Lustre: Skipped 1 previous similar message [ 6681.927513] Key type lgssc unregistered [ 6682.149858] LNet: 153059:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6682.154863] LNetError: 153059:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6682.208488] LNet: Removed LNI 192.168.206.29@tcp [ 6682.977303] Key type .llcrypt unregistered [ 6682.979754] Key type ._llcrypt unregistered [ 6697.381471] Key type ._llcrypt registered [ 6697.383609] Key type .llcrypt registered [ 6698.725487] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 15:59:44 (1787860784) [ 6699.819480] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6699.830675] alg: No test for adler32 (adler32-zlib) [ 6700.963207] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 6701.215523] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 6702.904472] Key type lgssc registered [ 6703.988575] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6761.806983] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6768.204759] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6792.679861] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6815.703860] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6816.155200] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6817.328139] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 6825.516924] LustreError: lustre-MDT0001-mdc-ffff9ff251abb000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6825.561551] Lustre: lustre-MDT0001-mdc-ffff9ff251abb000: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 6831.422436] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6833.574541] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6856.211959] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6861.493682] Lustre: Unmounted lustre-client [ 6893.164567] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 16:02:59 (1787860979) [ 6977.795299] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6982.732485] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7005.430166] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7006.196888] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 7032.848910] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7034.410564] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7037.940394] Lustre: lustre-OST0001-osc-ffff9ff249d85000: Connection to lustre-OST0001 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7045.778714] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7056.174387] Lustre: Unmounted lustre-client [ 7090.053661] Key type lgssc unregistered [ 7090.305550] LNet: 162698:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7090.312367] LNetError: 162698:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7090.332231] LNet: Removed LNI 192.168.206.29@tcp [ 7091.028949] Key type .llcrypt unregistered [ 7091.030499] Key type ._llcrypt unregistered [ 7120.636553] Key type ._llcrypt registered [ 7120.638543] Key type .llcrypt registered [ 7121.886442] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 16:06:47 (1787861207) [ 7124.714046] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7124.752696] alg: No test for adler32 (adler32-zlib) [ 7125.843350] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 7126.112805] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 7127.776175] Key type lgssc registered [ 7129.151828] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7180.636629] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7185.634815] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7205.366792] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7207.299427] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 7254.204150] Lustre: Unmounted lustre-client [ 7295.667675] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7296.224307] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 7331.657237] Lustre: Unmounted lustre-client [ 7360.601807] Key type lgssc unregistered [ 7360.883602] LNet: 167142:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7360.900305] LNetError: 167142:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7360.924667] LNet: Removed LNI 192.168.206.29@tcp [ 7361.850083] Key type .llcrypt unregistered [ 7361.856414] Key type ._llcrypt unregistered [ 7380.187571] Key type ._llcrypt registered [ 7380.190402] Key type .llcrypt registered [ 7381.528709] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 16:11:07 (1787861467) [ 7384.199809] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7384.256491] alg: No test for adler32 (adler32-zlib) [ 7385.474577] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 7385.727030] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 7387.408297] Key type lgssc registered [ 7388.634056] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7436.172348] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7440.920280] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7460.924622] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7462.779763] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 7482.112218] Lustre: Unmounted lustre-client [ 7508.950780] Key type lgssc unregistered [ 7509.263819] LNet: 170904:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7509.278533] LNetError: 170904:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7509.303971] LNet: Removed LNI 192.168.206.29@tcp [ 7510.121086] Key type .llcrypt unregistered [ 7510.125520] Key type ._llcrypt unregistered [ 7521.152059] Key type ._llcrypt registered [ 7521.158837] Key type .llcrypt registered [ 7521.737856] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7521.751055] alg: No test for adler32 (adler32-zlib) [ 7522.773556] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 7523.063316] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 7524.776196] Key type lgssc registered [ 7526.028139] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7578.402532] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7582.762957] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7603.559513] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7605.117441] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 7615.604560] Lustre: Unmounted lustre-client [ 7641.416943] Key type lgssc unregistered [ 7641.720299] LNet: 173972:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7641.736246] LNetError: 173972:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7641.759550] LNet: Removed LNI 192.168.206.29@tcp [ 7642.432947] Key type .llcrypt unregistered [ 7642.438774] Key type ._llcrypt unregistered [ 7655.993604] Key type ._llcrypt registered [ 7655.995641] Key type .llcrypt registered [ 7656.974869] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 16:15:43 (1787861743) [ 7659.164204] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7659.181255] alg: No test for adler32 (adler32-zlib) [ 7660.413870] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 7660.737780] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 7662.473146] Key type lgssc registered [ 7663.626434] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7710.702678] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7715.772517] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7736.074809] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7738.805749] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 7755.051887] Lustre: Unmounted lustre-client [ 7783.147912] Key type lgssc unregistered [ 7783.400397] LNet: 177731:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7783.421371] LNetError: 177731:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7783.453097] LNet: Removed LNI 192.168.206.29@tcp [ 7784.241129] Key type .llcrypt unregistered [ 7784.244872] Key type ._llcrypt unregistered [ 7795.932559] Key type ._llcrypt registered [ 7795.941555] Key type .llcrypt registered [ 7796.326869] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7796.344867] alg: No test for adler32 (adler32-zlib) [ 7797.375652] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 7797.583180] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 7799.249267] Key type lgssc registered [ 7800.366451] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7847.624438] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7852.621737] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7872.043722] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7874.151435] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 7881.782796] Lustre: Unmounted lustre-client [ 7904.940572] Key type lgssc unregistered [ 7905.246253] LNet: 180796:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7905.256949] LNetError: 180796:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7905.292615] LNet: Removed LNI 192.168.206.29@tcp [ 7906.643645] Key type .llcrypt unregistered [ 7906.645300] Key type ._llcrypt unregistered [ 7927.499339] Key type ._llcrypt registered [ 7927.501603] Key type .llcrypt registered [ 7929.343950] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 16:20:14 (1787862014) [ 7957.621750] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7957.634574] alg: No test for adler32 (adler32-zlib) [ 7958.765941] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 7959.103307] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 7960.872666] Key type lgssc registered [ 7962.242821] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8050.505941] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8056.422102] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8080.022239] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8122.187111] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 16:23:28 (1787862208) [ 8155.721518] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8160.995827] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8182.787288] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8184.572443] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 8189.763653] Lustre: Unmounted lustre-client [ 8219.517634] Key type lgssc unregistered [ 8219.820676] LNet: 187904:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8219.827611] LNetError: 187904:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8219.855626] LNet: Removed LNI 192.168.206.29@tcp [ 8220.779971] Key type .llcrypt unregistered [ 8220.783904] Key type ._llcrypt unregistered [ 8241.303265] Key type ._llcrypt registered [ 8241.308042] Key type .llcrypt registered [ 8242.547943] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8244.853630] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 16:25:30 (1787862330) [ 8266.316870] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8266.405158] alg: No test for adler32 (adler32-zlib) [ 8267.702443] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 8268.026494] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 8269.768194] Key type lgssc registered [ 8271.601229] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8360.512945] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8366.355488] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8387.595900] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8407.726543] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8410.358786] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 8430.963111] Lustre: Unmounted lustre-client [ 8559.319149] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8565.602205] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8590.906693] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8639.109768] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 16:32:05 (1787862725) [ 8640.658733] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8642.225292] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 16:32:08 (1787862728) [ 8742.188900] Key type lgssc unregistered [ 8742.444876] LNet: 199343:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8742.453498] LNetError: 199343:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8742.471294] LNet: Removed LNI 192.168.206.29@tcp [ 8743.224674] Key type .llcrypt unregistered [ 8743.227985] Key type ._llcrypt unregistered [ 8759.175281] Key type ._llcrypt registered [ 8759.178801] Key type .llcrypt registered [ 8760.314745] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 16:34:06 (1787862846) [ 8805.286398] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8805.344490] alg: No test for adler32 (adler32-zlib) [ 8806.523848] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 8806.834754] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 8808.496209] Key type lgssc registered [ 8809.834377] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8859.076047] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8865.355159] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8902.655609] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8931.730822] Key type lgssc unregistered [ 8932.102588] LNet: 203083:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8932.112207] LNetError: 203083:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8932.128473] LNet: Removed LNI 192.168.206.29@tcp [ 8932.814693] Key type .llcrypt unregistered [ 8932.821205] Key type ._llcrypt unregistered [ 8947.873467] Key type ._llcrypt registered [ 8947.876055] Key type .llcrypt registered [ 8949.220789] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 16:37:15 (1787863035) [ 8951.709964] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8951.722453] alg: No test for adler32 (adler32-zlib) [ 8952.787205] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 8953.033683] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 8954.760791] Key type lgssc registered [ 8955.983735] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9002.922355] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9009.946943] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9038.700550] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9041.644965] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 9052.138026] Lustre: lustre-MDT0000-mdc-ffff9ff247fe5800: Connection to lustre-MDT0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9062.375739] Lustre: lustre-MDT0001-mdc-ffff9ff247fe5800: Connection to lustre-MDT0001 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9073.632276] Lustre: 204074:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787863144/real 1787863144] req@000000005119ba0c x1874710275113088/t0(0) o400->MGC192.168.206.129@tcp@192.168.206.129@tcp:26/25 lens 224/224 e 0 to 1 dl 1787863160 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9073.688931] LustreError: MGC192.168.206.129@tcp: Connection to MGS (at 192.168.206.129@tcp) was lost; in progress operations using this service will fail [ 9083.946119] Lustre: Evicted from MGS (at 192.168.206.129@tcp) after server handle changed from 0x379399db4c1027de to 0x379399db4c104328 [ 9083.973370] Lustre: MGC192.168.206.129@tcp: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 9092.589111] Lustre: 206197:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.206.129@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 9122.297328] LustreError: lustre-MDT0000-mdc-ffff9ff247fe5800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9122.322792] Lustre: lustre-MDT0000-mdc-ffff9ff247fe5800: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 9130.449440] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9131.801838] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9137.375308] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9139.124742] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9142.135978] Lustre: Unmounted lustre-client [ 9171.362428] Key type lgssc unregistered [ 9171.763045] LNet: 208030:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9171.778952] LNetError: 208030:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9171.804199] LNet: Removed LNI 192.168.206.29@tcp [ 9172.650097] Key type .llcrypt unregistered [ 9172.653930] Key type ._llcrypt unregistered [ 9189.861175] Key type ._llcrypt registered [ 9189.862834] Key type .llcrypt registered [ 9191.649753] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 16:41:17 (1787863277) [ 9194.723682] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9194.744265] alg: No test for adler32 (adler32-zlib) [ 9195.991398] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 9196.382560] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 9198.032182] Key type lgssc registered [ 9199.433790] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9250.688267] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9256.369359] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9307.557583] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9314.599803] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9352.576606] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9377.698797] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9418.405987] Key type lgssc unregistered [ 9418.726300] LNet: 213330:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9418.738061] LNetError: 213330:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9418.771122] LNet: Removed LNI 192.168.206.29@tcp [ 9419.816864] Key type .llcrypt unregistered [ 9419.829109] Key type ._llcrypt unregistered [ 9463.880141] Key type ._llcrypt registered [ 9463.881966] Key type .llcrypt registered [ 9465.338540] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 16:45:51 (1787863551) [ 9502.974663] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9503.084044] alg: No test for adler32 (adler32-zlib) [ 9504.211827] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [ 9504.472663] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [ 9506.128956] Key type lgssc registered [ 9507.340484] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9588.590266] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9593.954606] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9619.502210] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9663.826398] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 16:49:09 (1787863749) [ 9671.023977] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 16:49:17 (1787863757) [ 9703.862679] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9709.542935] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9731.035321] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9732.531279] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 9742.075885] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9744.736136] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9746.165430] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9747.833918] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9753.066378] Lustre: lustre-MDT0000-mdc-ffff9ff24721e000: Connection to lustre-MDT0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9769.440896] Lustre: 215222:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787863840/real 1787863840] req@00000000a061af87 x1874710852806912/t0(0) o400->MGC192.168.206.129@tcp@192.168.206.129@tcp:26/25 lens 224/224 e 0 to 1 dl 1787863856 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9769.484145] LustreError: MGC192.168.206.129@tcp: Connection to MGS (at 192.168.206.129@tcp) was lost; in progress operations using this service will fail [ 9778.663952] Lustre: Evicted from MGS (at 192.168.206.129@tcp) after server handle changed from 0x3ba51398ebefc4a1 to 0x3ba51398ebefc717 [ 9778.683928] Lustre: MGC192.168.206.129@tcp: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 9783.898433] Lustre: lustre-MDT0000-mdc-ffff9ff24721e000: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 9798.006522] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9800.477588] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9804.771988] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9809.406875] Lustre: lustre-MDT0000-mdc-ffff9ff24721e000: Connection to lustre-MDT0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9824.736240] Lustre: 215221:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787863896/real 1787863896] req@000000004724af90 x1874710852816640/t0(0) o400->MGC192.168.206.129@tcp@192.168.206.129@tcp:26/25 lens 224/224 e 0 to 1 dl 1787863912 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9824.778480] LustreError: MGC192.168.206.129@tcp: Connection to MGS (at 192.168.206.129@tcp) was lost; in progress operations using this service will fail [ 9834.987461] Lustre: Evicted from MGS (at 192.168.206.129@tcp) after server handle changed from 0x3ba51398ebefc717 to 0x3ba51398ebefc92b [ 9834.999350] Lustre: MGC192.168.206.129@tcp: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 9841.769571] Lustre: lustre-MDT0000-mdc-ffff9ff24721e000: Connection restored to 192.168.206.129@tcp (at 192.168.206.129@tcp) [ 9851.028402] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9852.313638] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9857.125259] Lustre: Unmounted lustre-client [ 9927.576553] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9933.113060] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9953.066613] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9953.593078] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [ 9956.019627] Lustre: Unmounted lustre-client [ 9993.027700] Key type lgssc unregistered [ 9993.329389] LNet: 225807:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9993.336437] LNetError: 225807:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9993.365423] LNet: Removed LNI 192.168.206.29@tcp [ 9994.131832] Key type .llcrypt unregistered [ 9994.134259] Key type ._llcrypt unregistered [10011.700778] Key type ._llcrypt registered [10011.703444] Key type .llcrypt registered [10013.365067] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 16:54:58 (1787864098) [10017.886729] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10017.938903] alg: No test for adler32 (adler32-zlib) [10019.143338] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [10019.472617] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [10021.216623] Key type lgssc registered [10022.740029] Lustre: Echo OBD driver; http://www.lustre.org/ [10076.117778] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10081.619420] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10103.424395] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10106.119350] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [10115.195233] Lustre: Unmounted lustre-client [10182.718178] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10188.800993] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10208.593678] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10209.315856] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [10219.830416] Lustre: Unmounted lustre-client [10288.723476] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10294.777428] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10316.884705] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10317.615269] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [10319.983294] Lustre: Unmounted lustre-client [10346.856632] Key type lgssc unregistered [10347.070402] LNet: 232856:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10347.084179] LNetError: 232856:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10347.110456] LNet: Removed LNI 192.168.206.29@tcp [10347.921887] Key type .llcrypt unregistered [10347.925049] Key type ._llcrypt unregistered [10363.797072] Key type ._llcrypt registered [10363.800109] Key type .llcrypt registered [10365.130826] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 17:00:50 (1787864450) [10368.590287] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10368.625727] alg: No test for adler32 (adler32-zlib) [10369.781953] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [10370.068741] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [10371.736362] Key type lgssc registered [10372.942419] Lustre: Echo OBD driver; http://www.lustre.org/ [10414.363106] Key type lgssc unregistered [10414.570728] LNet: 235189:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10414.579212] LNetError: 235189:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10414.598834] LNet: Removed LNI 192.168.206.29@tcp [10415.317922] Key type .llcrypt unregistered [10415.321656] Key type ._llcrypt unregistered [10442.668222] Key type ._llcrypt registered [10442.671750] Key type .llcrypt registered [10443.072816] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10443.084871] alg: No test for adler32 (adler32-zlib) [10444.138602] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [10444.359595] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [10445.992184] Key type lgssc registered [10446.965978] Lustre: Echo OBD driver; http://www.lustre.org/ [10520.105076] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10525.656481] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10547.059404] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10585.243913] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10586.587617] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 17:04:32 (1787864672) [10623.088660] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10628.528298] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10645.361381] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10665.335591] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10666.912158] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [10672.108427] Lustre: lustre-OST0001-osc-ffff9ff250ee5800: Connection to lustre-OST0001 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [10677.999889] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10688.340399] Lustre: Unmounted lustre-client [10727.694641] Key type lgssc unregistered [10727.928863] LNet: 242312:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10727.934816] LNetError: 242312:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10727.952203] LNet: Removed LNI 192.168.206.29@tcp [10728.496266] Key type .llcrypt unregistered [10728.498722] Key type ._llcrypt unregistered [10754.678408] Key type ._llcrypt registered [10754.679897] Key type .llcrypt registered [10755.962956] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 17:07:21 (1787864841) [10767.436416] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10767.524596] alg: No test for adler32 (adler32-zlib) [10768.569483] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [10768.896812] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [10770.576234] Key type lgssc registered [10771.563423] Lustre: Echo OBD driver; http://www.lustre.org/ [10815.668633] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10820.238632] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10839.702221] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 17:08:45 (1787864925) [10866.760396] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10871.338343] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10893.457360] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10896.144834] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [10902.286252] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [10911.796345] Lustre: Unmounted lustre-client [11009.211753] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11013.954583] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11060.018168] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11060.729576] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [11062.844939] Lustre: Unmounted lustre-client [11097.781779] Key type lgssc unregistered [11098.075325] LNet: 250023:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11098.101221] LNetError: 250023:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11098.136392] LNet: Removed LNI 192.168.206.29@tcp [11098.691216] Key type .llcrypt unregistered [11098.695227] Key type ._llcrypt unregistered [11126.179828] Key type ._llcrypt registered [11126.181559] Key type .llcrypt registered [11126.435430] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11126.444701] alg: No test for adler32 (adler32-zlib) [11127.518339] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [11127.772587] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [11129.504267] Key type lgssc registered [11130.882721] Lustre: Echo OBD driver; http://www.lustre.org/ [11207.206424] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11211.796442] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11230.641387] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11269.393901] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11271.811786] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 17:15:57 (1787865357) [11304.428868] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11309.448085] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11332.221750] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11337.910731] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [11341.127337] Lustre: Unmounted lustre-client [11376.494746] Key type lgssc unregistered [11376.749255] LNet: 256665:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11376.757701] LNetError: 256665:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11376.793537] LNet: Removed LNI 192.168.206.29@tcp [11377.381162] Key type .llcrypt unregistered [11377.383550] Key type ._llcrypt unregistered [11392.109578] Key type ._llcrypt registered [11392.111396] Key type .llcrypt registered [11393.471606] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11394.838409] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 17:18:01 (1787865481) [11404.024154] Key type .llcrypt unregistered [11404.034769] Key type ._llcrypt unregistered [11412.265432] Key type ._llcrypt registered [11412.267211] Key type .llcrypt registered [11412.700605] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11412.721385] alg: No test for adler32 (adler32-zlib) [11413.818194] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [11414.046494] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [11415.696348] Key type lgssc registered [11416.753745] Lustre: Echo OBD driver; http://www.lustre.org/ [11470.079870] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11484.679912] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [11487.282682] Lustre: Unmounted lustre-client [11512.830595] Key type lgssc unregistered [11513.040775] LNet: 260125:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11513.050749] LNetError: 260125:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11513.065874] LNet: Removed LNI 192.168.206.29@tcp [11513.709051] Key type .llcrypt unregistered [11513.712623] Key type ._llcrypt unregistered [11527.063380] Key type ._llcrypt registered [11527.066616] Key type .llcrypt registered [11528.371463] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 17:20:14 (1787865614) [11530.328777] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11530.342270] alg: No test for adler32 (adler32-zlib) [11531.367262] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [11531.606490] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [11533.288174] Key type lgssc registered [11534.220162] Lustre: Echo OBD driver; http://www.lustre.org/ [11616.831982] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11653.331430] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11658.891721] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11660.650935] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [11663.953889] Lustre: Unmounted lustre-client [11701.516465] Key type lgssc unregistered [11701.808751] LNet: 263678:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11701.824555] LNetError: 263678:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11701.846631] LNet: Removed LNI 192.168.206.29@tcp [11702.940645] Key type .llcrypt unregistered [11702.947653] Key type ._llcrypt unregistered [11723.414961] Key type ._llcrypt registered [11723.416734] Key type .llcrypt registered [11725.298857] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 17:23:30 (1787865810) [11728.415751] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11728.487222] alg: No test for adler32 (adler32-zlib) [11729.747210] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [11730.047700] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [11731.688306] Key type lgssc registered [11733.321388] Lustre: Echo OBD driver; http://www.lustre.org/ [11794.398445] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11802.186387] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11827.495503] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11834.469902] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [11839.486585] Lustre: lustre-MDT0000-mdc-ffff9ff247fe7800: Connection to lustre-MDT0000 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [11845.988198] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11846.024153] LustreError: 266842:0:(file.c:6184:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [11846.559994] LustreError: 266853:0:(file.c:6184:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [11846.565519] LustreError: 266853:0:(file.c:6184:ll_inode_revalidate_fini()) Skipped 3 previous similar messages [11846.693264] LustreError: MGC192.168.206.129@tcp: Connection to MGS (at 192.168.206.129@tcp) was lost; in progress operations using this service will fail [11846.811154] Lustre: Unmounted lustre-client [11868.084566] Key type lgssc unregistered [11868.461119] LNet: 267258:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11868.467969] LNetError: 267258:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11868.487663] LNet: Removed LNI 192.168.206.29@tcp [11869.328727] Key type .llcrypt unregistered [11869.331920] Key type ._llcrypt unregistered [11887.200358] Key type ._llcrypt registered [11887.203667] Key type .llcrypt registered [11888.500368] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 17:26:14 (1787865974) [11890.751754] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11890.861116] alg: No test for adler32 (adler32-zlib) [11891.916299] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [11892.181752] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [11893.944752] Key type lgssc registered [11894.944643] Lustre: Echo OBD driver; http://www.lustre.org/ [11955.397910] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11961.501320] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11983.433617] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11995.741358] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [12000.742844] Lustre: lustre-MDT0001-mdc-ffff9ff249e50000: Connection to lustre-MDT0001 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [12006.927503] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12009.672945] Lustre: Unmounted lustre-client [12029.950555] Key type lgssc unregistered [12030.254141] LNet: 270849:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12030.265157] LNetError: 270849:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12031.335495] LNet: Removed LNI 192.168.206.29@tcp [12032.089212] Key type .llcrypt unregistered [12032.093295] Key type ._llcrypt unregistered [12049.353956] Key type ._llcrypt registered [12049.356439] Key type .llcrypt registered [12050.818963] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 17:28:56 (1787866136) [12070.168558] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12070.253403] alg: No test for adler32 (adler32-zlib) [12071.304239] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [12071.519573] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [12073.272239] Key type lgssc registered [12074.574468] Lustre: Echo OBD driver; http://www.lustre.org/ [12189.130964] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12190.800203] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [12234.226203] Lustre: lustre-MDT0001-mdc-ffff9ff247fe6800: Connection to lustre-MDT0001 (at 192.168.206.129@tcp) was lost; in progress operations using this service will wait for recovery to complete [12241.959649] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12252.304829] Lustre: Unmounted lustre-client [12279.151524] Key type lgssc unregistered [12279.380683] LNet: 276643:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12279.389326] LNetError: 276643:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12279.420816] LNet: Removed LNI 192.168.206.29@tcp [12280.213209] Key type .llcrypt unregistered [12280.216535] Key type ._llcrypt unregistered [12297.329982] Key type ._llcrypt registered [12297.331974] Key type .llcrypt registered [12299.367808] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 17:33:04 (1787866384) [12301.281947] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12303.302831] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 17:33:09 (1787866389) [12304.955377] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12306.906566] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 17:33:12 (1787866392) [12308.729296] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12310.604704] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 17:33:16 (1787866396) [12312.690457] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12314.542679] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 17:33:20 (1787866400) [12316.586567] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12318.790568] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 17:33:24 (1787866404) [12329.285293] Key type .llcrypt unregistered [12329.287813] Key type ._llcrypt unregistered [12337.040938] Key type ._llcrypt registered [12337.043704] Key type .llcrypt registered [12337.593165] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12337.602900] alg: No test for adler32 (adler32-zlib) [12338.796502] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [12339.077650] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [12340.784216] Key type lgssc registered [12341.953765] Lustre: Echo OBD driver; http://www.lustre.org/ [12417.453533] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12424.288679] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12446.121394] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12448.735893] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [12451.338129] Lustre: Unmounted lustre-client [12490.993593] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 17:36:16 (1787866576) [12532.492715] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12538.946413] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12573.786318] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12574.570437] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [12577.424579] Lustre: Unmounted lustre-client [12622.877940] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 17:38:28 (1787866708) [12628.896436] LNet: 1 local NIs in recovery (showing 1): 192.168.206.29@tcp [13282.764362] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13289.912618] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13325.678481] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13427.146601] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 17:51:53 (1787867513) [13441.265899] Key type lgssc unregistered [13441.483539] LNet: 290180:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13441.504707] LNetError: 290180:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13442.553252] LNet: Removed LNI 192.168.206.29@tcp [13443.285710] Key type .llcrypt unregistered [13443.290739] Key type ._llcrypt unregistered [13575.414756] Key type ._llcrypt registered [13575.423245] Key type .llcrypt registered [13575.890106] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13575.916942] alg: No test for adler32 (adler32-zlib) [13577.158420] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [13577.532222] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [13579.216464] Key type lgssc registered [13581.072874] Lustre: Echo OBD driver; http://www.lustre.org/ [13685.728220] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13692.637985] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13719.036624] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13760.603207] Key type lgssc unregistered [13760.864199] LNet: 293884:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13760.871475] LNetError: 293884:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13760.896324] LNet: Removed LNI 192.168.206.29@tcp [13761.552727] Key type .llcrypt unregistered [13761.556870] Key type ._llcrypt unregistered [13800.836825] Key type ._llcrypt registered [13800.843535] Key type .llcrypt registered [13802.357448] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 17:58:07 (1787867887) [13829.886582] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13829.937887] alg: No test for adler32 (adler32-zlib) [13831.074985] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [13831.325894] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [13833.016201] Key type lgssc registered [13834.594292] Lustre: Echo OBD driver; http://www.lustre.org/ [13884.795871] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 17:59:30 (1787867970) [13895.982128] Key type lgssc unregistered [13896.273767] LNet: 297442:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13896.283964] LNetError: 297442:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13896.298064] LNet: Removed LNI 192.168.206.29@tcp [13897.066170] Key type .llcrypt unregistered [13897.071310] Key type ._llcrypt unregistered [13909.327739] Key type ._llcrypt registered [13909.334180] Key type .llcrypt registered [13909.943071] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13909.964771] alg: No test for adler32 (adler32-zlib) [13911.023423] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [13911.261575] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [13913.000304] Key type lgssc registered [13914.212601] Lustre: Echo OBD driver; http://www.lustre.org/ [13972.434488] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13979.429523] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14006.289521] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14321.449990] LNet: Added LNI 192.168.206.29@tcp50 [8/256/0/180] [14324.723892] LNet: Removed LNI 192.168.206.29@tcp [14327.102807] Lustre: 301855:0:(ldlm_lib.c:571:client_obd_setup()) lustre-MDT0000-mdc-ffff9ff253b82000: config has no valid NIDs, force dynamic NIDs [14328.400878] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [14328.636565] Lustre: Unmounted lustre-client [14330.841242] Key type lgssc unregistered [14331.278588] LNet: 302117:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14331.306442] LNetError: 302117:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14331.350927] LNet: Removed LNI 192.168.206.29@tcp50 [14332.095394] Key type .llcrypt unregistered [14332.104322] Key type ._llcrypt unregistered [14350.450794] Key type ._llcrypt registered [14350.452801] Key type .llcrypt registered [14350.802393] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14350.844726] alg: No test for adler32 (adler32-zlib) [14351.952891] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [14352.241673] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [14353.984297] Key type lgssc registered [14355.434491] Lustre: Echo OBD driver; http://www.lustre.org/ [14414.788950] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14420.388671] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14428.456413] LNet: Added LNI 192.168.206.29@tcp50 [8/256/0/180] [14429.340480] LNet: Removed LNI 192.168.206.29@tcp [14430.566902] Lustre: 304807:0:(ldlm_lib.c:571:client_obd_setup()) lustre-MDT0000-mdc-ffff9ff242e98000: config has no valid NIDs, force dynamic NIDs [14431.845485] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [14432.582276] Lustre: Unmounted lustre-client [14484.995683] Key type lgssc unregistered [14485.392695] LNet: 305684:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14485.403738] LNetError: 305684:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14485.425895] LNet: Removed LNI 192.168.206.29@tcp50 [14486.024953] Key type .llcrypt unregistered [14486.026941] Key type ._llcrypt unregistered [14497.458891] Key type ._llcrypt registered [14497.460553] Key type .llcrypt registered [14499.067780] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 18:09:44 (1787868584) [14523.876275] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14524.047171] alg: No test for adler32 (adler32-zlib) [14525.471978] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [14525.849733] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [14527.576187] Key type lgssc registered [14528.957323] Lustre: Echo OBD driver; http://www.lustre.org/ [14619.244805] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14624.947563] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14650.305631] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14694.099401] Key type lgssc unregistered [14694.349974] LNet: 310439:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14694.358101] LNetError: 310439:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14694.378087] LNet: Removed LNI 192.168.206.29@tcp [14695.085949] Key type .llcrypt unregistered [14695.087513] Key type ._llcrypt unregistered [14704.977465] Key type ._llcrypt registered [14704.988903] Key type .llcrypt registered [14706.150890] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 18:13:12 (1787868792) [14708.490155] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14708.513928] alg: No test for adler32 (adler32-zlib) [14709.526296] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [14709.753528] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [14711.384334] Key type lgssc registered [14712.605884] Lustre: Echo OBD driver; http://www.lustre.org/ [14760.726403] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14766.162336] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14786.822778] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14789.429393] Lustre: Mounted lustre-client - version 2.17.57_83_g3de4944 [14854.785446] Lustre: Mounted fs15246-client - version 2.17.57_83_g3de4944 [14869.604686] Lustre: Unmounted fs15246-client [14898.932045] Lustre: Unmounted lustre-client [14926.115850] Key type lgssc unregistered [14926.490883] LNet: 315308:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14926.500152] LNetError: 315308:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14926.523978] LNet: Removed LNI 192.168.206.29@tcp [14927.297809] Key type .llcrypt unregistered [14927.301099] Key type ._llcrypt unregistered [14939.179821] Key type ._llcrypt registered [14939.183239] Key type .llcrypt registered [14940.433521] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 18:17:06 (1787869026) [14942.237507] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14942.397819] alg: No test for adler32 (adler32-zlib) [14943.488602] Lustre: Lustre: Build Version: 2.17.57_83_g3de4944 [14943.687735] LNet: Added LNI 192.168.206.29@tcp [8/256/0/180] [14945.376231] Key type lgssc registered [14946.819286] Lustre: Echo OBD driver; http://www.lustre.org/ [15072.408425] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15077.277697] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15098.526600] Lustre: DEBUG MARKER: oleg629-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15188.388129] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 14907 sec ========= 18:21:14 (1787869274) [15189.843084] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 18:21:15 (1787869275) === [15193.364252] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 18:21:19 (1787869279) === [15225.480717] Key type lgssc unregistered [15225.819609] LNet: 324575:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15225.830791] LNetError: 324575:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15225.856216] LNet: Removed LNI 192.168.206.29@tcp [15226.545353] Key type .llcrypt unregistered [15226.549289] Key type ._llcrypt unregistered