[ 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 448200628 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 2624MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001012] APIC: Switch to symmetric I/O mode setup [ 0.003062] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.008000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009013] pid_max: default: 32768 minimum: 301 [ 0.010122] LSM: Security Framework initializing [ 0.011047] Yama: becoming mindful. [ 0.013026] SELinux: Initializing. [ 0.014000] *** VALIDATE selinux *** [ 0.021667] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026864] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028165] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029117] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031060] *** VALIDATE tmpfs *** [ 0.032255] *** VALIDATE proc *** [ 0.033260] *** VALIDATE cgroup *** [ 0.034013] *** VALIDATE cgroup2 *** [ 0.035272] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037167] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039036] Spectre V2 : User space: Vulnerable [ 0.040010] Speculative Store Bypass: Vulnerable [ 0.043165] debug: unmapping init [mem 0xffffffffa6659000-0xffffffffa6660fff] [ 0.045196] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046696] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047023] ... version: 2 [ 0.048014] ... bit width: 48 [ 0.049016] ... generic registers: 4 [ 0.050014] ... value mask: 0000ffffffffffff [ 0.051016] ... max period: 00007fffffffffff [ 0.052010] ... fixed-purpose events: 3 [ 0.053013] ... event mask: 000000070000000f [ 0.054289] rcu: Hierarchical SRCU implementation. [ 0.056554] smp: Bringing up secondary CPUs ... [ 0.057635] x86: Booting SMP configuration: [ 0.058028] .... node #0, CPUs: #1 #2 #3 [ 0.061754] smp: Brought up 1 node, 4 CPUs [ 0.063016] smpboot: Max logical packages: 1 [ 0.064016] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.297346] node 0 deferred pages initialised in 229ms [ 0.300458] devtmpfs: initialized [ 0.301231] x86/mm: Memory block size: 128MB [ 0.304045] gcov: version magic: 0x41383552 [ 0.306389] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.307095] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.308309] pinctrl core: initialized pinctrl subsystem [ 0.309273] [ 0.309878] ************************************************************* [ 0.310018] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.311013] ** ** [ 0.312022] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.313030] ** ** [ 0.314016] ** This means that this kernel is built to expose internal ** [ 0.315017] ** IOMMU data structures, which may compromise security on ** [ 0.316016] ** your system. ** [ 0.317016] ** ** [ 0.318016] ** If you see this message and you are not debugging the ** [ 0.319016] ** kernel, report this immediately to your vendor! ** [ 0.320022] ** ** [ 0.321019] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.322015] ************************************************************* [ 0.323994] NET: Registered protocol family 16 [ 0.324496] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.325067] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.326071] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.327485] cpuidle: using governor menu [ 0.330073] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.331604] PCI: Using configuration type 1 for base access [ 0.333122] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.341132] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.343060] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.347110] cryptd: max_cpu_qlen set to 1000 [ 0.350390] ACPI: Added _OSI(Module Device) [ 0.353092] ACPI: Added _OSI(Processor Device) [ 0.355022] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.357021] ACPI: Added _OSI(Processor Aggregator Device) [ 0.362355] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.369671] ACPI: Interpreter enabled [ 0.371069] ACPI: PM: (supports S0 S3 S4 S5) [ 0.373020] ACPI: Using IOAPIC for interrupt routing [ 0.374198] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.379472] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.388000] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.391064] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.394032] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.400132] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.406455] acpiphp: Slot [2] registered [ 0.408191] acpiphp: Slot [5] registered [ 0.409167] acpiphp: Slot [6] registered [ 0.411189] acpiphp: Slot [3] registered [ 0.413171] acpiphp: Slot [4] registered [ 0.414141] acpiphp: Slot [7] registered [ 0.416223] acpiphp: Slot [8] registered [ 0.417120] acpiphp: Slot [9] registered [ 0.419135] acpiphp: Slot [10] registered [ 0.420130] acpiphp: Slot [11] registered [ 0.422128] acpiphp: Slot [12] registered [ 0.424160] acpiphp: Slot [13] registered [ 0.425131] acpiphp: Slot [14] registered [ 0.427128] acpiphp: Slot [15] registered [ 0.429152] acpiphp: Slot [16] registered [ 0.430124] acpiphp: Slot [17] registered [ 0.432119] acpiphp: Slot [18] registered [ 0.434183] acpiphp: Slot [19] registered [ 0.435203] acpiphp: Slot [20] registered [ 0.437136] acpiphp: Slot [21] registered [ 0.439138] acpiphp: Slot [22] registered [ 0.440141] acpiphp: Slot [23] registered [ 0.441157] acpiphp: Slot [24] registered [ 0.442164] acpiphp: Slot [25] registered [ 0.444122] acpiphp: Slot [26] registered [ 0.445000] acpiphp: Slot [27] registered [ 0.445000] acpiphp: Slot [28] registered [ 0.447140] acpiphp: Slot [29] registered [ 0.448106] acpiphp: Slot [30] registered [ 0.449000] acpiphp: Slot [31] registered [ 0.450101] PCI host bridge to bus 0000:00 [ 0.452028] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.454035] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.455032] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.457041] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.459036] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.462041] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.463189] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.464885] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.467604] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.474630] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.480130] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.482021] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.485029] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.488033] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.490752] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.494836] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.496046] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.500065] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.504000] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.512021] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.517019] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.522115] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.527015] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.532020] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.550958] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.561207] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.569025] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.574025] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.597034] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.611000] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.613431] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.616377] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.620398] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.623272] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.629056] iommu: Default domain type: Passthrough [ 0.630426] SCSI subsystem initialized [ 0.632126] ACPI: bus type USB registered [ 0.634140] usbcore: registered new interface driver usbfs [ 0.636090] usbcore: registered new interface driver hub [ 0.638096] usbcore: registered new device driver usb [ 0.639198] pps_core: LinuxPPS API ver. 1 registered [ 0.641013] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.645078] PTP clock support registered [ 0.648101] EDAC MC: Ver: 3.0.0 [ 0.649405] PCI: Using ACPI for IRQ routing [ 0.650897] NetLabel: Initializing [ 0.651012] NetLabel: domain hash size = 128 [ 0.652014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.653153] NetLabel: unlabeled traffic allowed by default [ 0.655041] vgaarb: loaded [ 0.656333] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.658024] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.663414] clocksource: Switched to clocksource kvm-clock [ 0.775439] VFS: Disk quotas dquot_6.6.0 [ 0.777048] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.779741] *** VALIDATE ramfs *** [ 0.780849] *** VALIDATE hugetlbfs *** [ 0.782409] pnp: PnP ACPI init [ 0.784828] pnp: PnP ACPI: found 6 devices [ 0.808050] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.811632] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.813873] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.816310] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.819177] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.823899] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.826983] NET: Registered protocol family 2 [ 0.829567] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.834219] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.837830] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.843598] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.847266] TCP: Hash tables configured (established 65536 bind 65536) [ 0.850813] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.854599] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.857979] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.861559] NET: Registered protocol family 1 [ 0.864225] RPC: Registered named UNIX socket transport module. [ 0.866663] RPC: Registered udp transport module. [ 0.868407] RPC: Registered tcp transport module. [ 0.870324] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.872860] NET: Registered protocol family 44 [ 0.874814] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.877248] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.879650] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.882046] PCI: CLS 0 bytes, default 64 [ 0.884146] Unpacking initramfs... [ 2.300794] debug: unmapping init [mem 0xffff93da7cc64000-0xffff93da7ffcffff] [ 2.305733] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.308015] software IO TLB: mapped [mem 0x00000000b8c64000-0x00000000bcc64000] (64MB) [ 2.310881] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.851817] Initialise system trusted keyrings [ 2.854889] Key type blacklist registered [ 2.858374] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.869642] zbud: loaded [ 2.873127] *** VALIDATE nfs *** [ 2.874348] *** VALIDATE nfs4 *** [ 2.876096] pstore: using deflate compression [ 2.880136] Platform Keyring initialized [ 2.991386] NET: Registered protocol family 38 [ 2.993129] Key type asymmetric registered [ 2.994219] Asymmetric key parser 'x509' registered [ 2.996143] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.999216] io scheduler mq-deadline registered [ 3.000889] io scheduler kyber registered [ 3.002376] io scheduler bfq registered [ 3.004606] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.007139] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.010224] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.013085] ACPI: Power Button [PWRF] [ 3.018491] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.025916] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.039524] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.067124] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.095877] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.101490] Non-volatile memory driver v1.3 [ 3.103254] Linux agpgart interface v0.103 [ 3.140710] virtio_blk virtio1: [vda] 145912 512-byte logical blocks (74.7 MB/71.2 MiB) [ 3.143831] vda: detected capacity change from 0 to 74706944 [ 3.165921] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.169078] vdb: detected capacity change from 0 to 1073741824 [ 3.175504] libphy: Fixed MDIO Bus: probed [ 3.182383] usbcore: registered new interface driver usbserial_generic [ 3.186468] usbserial: USB Serial support registered for generic [ 3.188176] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.191808] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.193817] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.196467] mousedev: PS/2 mouse device common for all mice [ 3.199396] rtc_cmos 00:05: RTC can wake from S4 [ 3.203055] rtc_cmos 00:05: registered as rtc0 [ 3.204157] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.205105] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.210566] intel_pstate: CPU model not supported [ 3.215342] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.217411] hid: raw HID events driver (C) Jiri Kosina [ 3.224531] usbcore: registered new interface driver usbhid [ 3.227163] usbhid: USB HID core driver [ 3.227438] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.229488] drop_monitor: Initializing network drop monitor service [ 3.234424] Initializing XFRM netlink socket [ 3.236551] NET: Registered protocol family 10 [ 3.239818] Segment Routing with IPv6 [ 3.241203] NET: Registered protocol family 17 [ 3.243494] mpls_gso: MPLS GSO support [ 3.250504] RAS: Correctable Errors collector initialized. [ 3.252668] AVX version of gcm_enc/dec engaged. [ 3.254506] AES CTR mode by8 optimization enabled [ 3.332089] sched_clock: Marking stable (3332061485, 0)->(4309844933, -977783448) [ 3.336294] registered taskstats version 1 [ 3.340156] Loading compiled-in X.509 certificates [ 3.342302] zswap: loaded using pool lzo/zbud [ 3.366427] Key type big_key registered [ 3.379801] Key type encrypted registered [ 3.381819] ima: No TPM chip found, activating TPM-bypass! [ 3.384287] ima: Allocated hash algorithm: sha1 [ 3.388179] ima: No architecture policies found [ 3.389987] evm: Initialising EVM extended attributes: [ 3.391815] evm: security.selinux [ 3.393039] evm: security.ima [ 3.394239] evm: security.capability [ 3.395693] evm: HMAC attrs: 0x1 [ 3.397885] rtc_cmos 00:05: setting system clock to 2026-08-11 03:10:20 UTC (1786417820) [ 3.403572] debug: unmapping init [mem 0xffffffffa7603000-0xffffffffa77fffff] [ 3.407992] debug: unmapping init [mem 0xffffffffa6382000-0xffffffffa6658fff] [ 3.416071] Write protecting the kernel read-only data: 28672k [ 3.419691] debug: unmapping init [mem 0xffffffffa4a03000-0xffffffffa4bfffff] [ 3.422764] debug: unmapping init [mem 0xffffffffa5314000-0xffffffffa53fffff] [ 3.453088] 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.461366] systemd[1]: Detected virtualization kvm. [ 3.463208] systemd[1]: Detected architecture x86-64. [ 3.465759] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.494555] systemd[1]: No hostname configured. [ 3.496805] systemd[1]: Set hostname to . [ 3.499182] random: systemd: uninitialized urandom read (16 bytes read) [ 3.502357] systemd[1]: Initializing machine ID from random generator. [ 3.536849] random: ln: uninitialized urandom read (6 bytes read) [ 3.654859] random: systemd: uninitialized urandom read (16 bytes read) [ 3.657430] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.661722] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 3.667285] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Initrd Root Device. [ OK ] Listening on udev Control Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Create Volatile Files and Directories... Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Started Memstrack Anylazing Service. Starting Journal Service... [ OK ] Reached target Swap. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ 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.309945] device-mapper: uevent: version 1.0.3 [ 4.311851] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ 4.944835] random: fast init done [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 4.981644] virtio_net virtio0 ens2: renamed from eth0 [ 5.001580] scsi host0: ata_piix [ 5.031156] scsi host1: ata_piix [ 5.032597] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.034383] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.927687] random: crng init done [ 9.936816] random: 7 urandom warning(s) missed due to ratelimiting [ 10.127700] dracut-initqueue[589]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 11.638922] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Timers. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped Apply Kernel Variables. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 14.208303] printk: systemd: 26 output lines suppressed due to ratelimiting [ 15.207231] SELinux: Disabled at runtime. [ 15.331613] 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) [ 15.368560] systemd[1]: Detected virtualization kvm. [ 15.370178] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 15.602011] hrtimer: interrupt took 16369270 ns [ 17.031498] systemd[1]: initrd-switch-root.service: Succeeded. [ 17.044855] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 17.070518] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 17.079174] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 17.089171] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 17.136879] systemd[1]: Starting Journal Service... Starting Journal Service... [ 17.172450] systemd[1]: Created slice User and Session Slice. [ OK ] Created slice User and Session Slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Activating swap /dev/disk/by-label/SWAP... [ OK ] Stopped target Switch Root. Mounting Huge Pages File System... [ OK ] Listening on initctl Compatibility Named Pipe. Mounting Kernel Debug File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Slices. [ 17.368042] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. Mounting POSIX Message Queue File System... [ OK ] Listening on udev Kernel Socket. [ OK ] Stopped target Initrd Root File System. Starting Remount Root and Kernel File Systems... [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Reached target Paths. [ OK ] Created slice system-sshd\x2dkeygen.slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Stopped target Initrd File Systems. [ OK ] Created slice system-getty.slice. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Reached target Local Encrypted Volumes. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Reached target Swap. [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 18.875395] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 19.844725] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 20.044846] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 20.362872] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 20.513082] EDAC sbridge: Ver: 1.1.2 [ 23.880530] Key type dns_resolver registered [ 24.566381] NFS: Registering the id_resolver key type [ 24.581490] Key type id_resolver registered [ 24.589740] Key type id_legacy registered [* ] A start job is running for Configur…-only root support (8s / no limit) [ 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 ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started Login Service. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg617-client login: [ 89.561464] libcfs: loading out-of-tree module taints kernel. [ 89.643310] Key type ._llcrypt registered [ 89.649077] Key type .llcrypt registered [ 90.040423] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 90.056465] alg: No test for adler32 (adler32-zlib) [ 91.450837] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 92.463197] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 94.256664] Key type lgssc registered [ 95.828513] Lustre: Echo OBD driver; http://www.lustre.org/ [ 259.941982] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 264.821165] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 281.025217] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing check_logdir /tmp/testlogs/ [ 285.673841] Lustre: lustre-OST0000-osc-ffff93dae0dc2000: disconnect after 23s idle [ 288.176956] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing yml_node [ 293.191093] Lustre: DEBUG MARKER: Client: 2.17.56.52 [ 296.741775] Lustre: DEBUG MARKER: MDS: 2.17.56.52 [ 299.515566] Lustre: DEBUG MARKER: OSS: 2.17.56.52 [ 301.055337] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon Aug 10 23:15:16 EDT 2026 [ 320.500741] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 322.745188] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 325.802326] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 336.137817] Lustre: Unmounted lustre-client [ 444.249832] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 450.692424] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 475.127512] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 512.286800] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 23:18:48 (1786418328) [ 515.103411] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 516.654211] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 23:18:52 (1786418332) [ 548.345254] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 553.583839] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 573.416835] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 574.298487] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 579.521163] Lustre: Unmounted lustre-client [ 607.849752] Key type lgssc unregistered [ 608.079241] LNet: 15040:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 608.098722] LNetError: 15040:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 608.123908] LNet: Removed LNI 192.168.206.17@tcp [ 609.233173] Key type .llcrypt unregistered [ 609.235513] Key type ._llcrypt unregistered [ 623.689775] Key type ._llcrypt registered [ 623.696529] Key type .llcrypt registered [ 624.986922] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 23:20:40 (1786418440) [ 626.280631] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 626.391675] alg: No test for adler32 (adler32-zlib) [ 627.431384] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 627.632383] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 629.336287] Key type lgssc registered [ 630.769207] Lustre: Echo OBD driver; http://www.lustre.org/ [ 699.718132] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 790.191098] Lustre: Unmounted lustre-client [ 811.157759] Key type lgssc unregistered [ 811.379393] LNet: 18856:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 811.395376] LNetError: 18856:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 811.419442] LNet: Removed LNI 192.168.206.17@tcp [ 812.106423] Key type .llcrypt unregistered [ 812.108402] Key type ._llcrypt unregistered [ 820.318258] Key type ._llcrypt registered [ 820.320588] Key type .llcrypt registered [ 821.384150] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 23:23:57 (1786418637) [ 823.923397] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 823.939491] alg: No test for adler32 (adler32-zlib) [ 825.077422] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 825.346243] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 827.032228] Key type lgssc registered [ 828.206024] Lustre: Echo OBD driver; http://www.lustre.org/ [ 873.532564] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 880.463521] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 899.987486] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 902.796459] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 916.969665] Lustre: Unmounted lustre-client [ 945.820984] Key type lgssc unregistered [ 946.153978] LNet: 22460:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 946.170704] LNetError: 22460:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 946.191076] LNet: Removed LNI 192.168.206.17@tcp [ 947.187786] Key type .llcrypt unregistered [ 947.189759] Key type ._llcrypt unregistered [ 957.849193] Key type ._llcrypt registered [ 957.851712] Key type .llcrypt registered [ 959.325439] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 23:26:14 (1786418774) [ 961.742172] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 961.830628] alg: No test for adler32 (adler32-zlib) [ 962.897589] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 963.193367] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 964.857567] Key type lgssc registered [ 965.849324] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1019.051609] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1025.051764] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1049.033689] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1050.698754] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 1059.639368] Lustre: Unmounted lustre-client [ 1087.146976] Key type lgssc unregistered [ 1087.375072] LNet: 25655:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1087.386388] LNetError: 25655:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1087.412969] LNet: Removed LNI 192.168.206.17@tcp [ 1088.085640] Key type .llcrypt unregistered [ 1088.087911] Key type ._llcrypt unregistered [ 1103.332671] Key type ._llcrypt registered [ 1103.343485] Key type .llcrypt registered [ 1104.900873] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 23:28:40 (1786418920) [ 1108.424158] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1108.456805] alg: No test for adler32 (adler32-zlib) [ 1109.488255] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 1109.750379] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 1111.512470] Key type lgssc registered [ 1113.280901] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1169.718947] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1175.405575] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1193.854511] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1195.245626] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 1200.617440] Lustre: lustre-MDT0000-mdc-ffff93dae0d8e000: Connection to lustre-MDT0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1205.747776] Lustre: lustre-MDT0001-mdc-ffff93dae0d8e000: Connection to lustre-MDT0001 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1212.767090] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1221.091615] Lustre: 26614:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786419022/real 1786419022] req@00000000a8d45525 x1873196011754880/t0(0) o400->MGC192.168.206.117@tcp@192.168.206.117@tcp:26/25 lens 224/224 e 0 to 1 dl 1786419038 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1221.123210] LustreError: MGC192.168.206.117@tcp: Connection to MGS (at 192.168.206.117@tcp) was lost; in progress operations using this service will fail [ 1223.157729] Lustre: Unmounted lustre-client [ 1243.677635] Key type lgssc unregistered [ 1243.984345] LNet: 29313:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1243.989891] LNetError: 29313:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1244.019885] LNet: Removed LNI 192.168.206.17@tcp [ 1244.863673] Key type .llcrypt unregistered [ 1244.865959] Key type ._llcrypt unregistered [ 1260.732760] Key type ._llcrypt registered [ 1260.734660] Key type .llcrypt registered [ 1262.190887] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 23:31:17 (1786419077) [ 1264.794718] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1264.853055] alg: No test for adler32 (adler32-zlib) [ 1265.941330] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 1266.157189] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 1267.856914] Key type lgssc registered [ 1269.211474] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1319.961543] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1326.545721] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1350.659663] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1353.496477] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 1358.840862] Lustre: lustre-OST0000-osc-ffff93dad8751000: Connection to lustre-OST0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1366.628476] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1377.019294] Lustre: Unmounted lustre-client [ 1406.188077] Key type lgssc unregistered [ 1406.499741] LNet: 32924:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1406.515152] LNetError: 32924:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1406.530699] LNet: Removed LNI 192.168.206.17@tcp [ 1407.300512] Key type .llcrypt unregistered [ 1407.302582] Key type ._llcrypt unregistered [ 1423.549682] Key type ._llcrypt registered [ 1423.552216] Key type .llcrypt registered [ 1424.983361] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 23:34:00 (1786419240) [ 1427.402231] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1427.474056] alg: No test for adler32 (adler32-zlib) [ 1428.624760] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 1428.935947] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 1430.712231] Key type lgssc registered [ 1431.983278] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1483.919728] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1489.977647] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1511.581404] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1513.251143] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 1520.242630] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1523.336408] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1535.082908] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-1023h35m50s [ 1537.365207] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1544.176373] Lustre: lustre-MDT0000-mdc-ffff93dac5ef9000: Connection to lustre-MDT0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1547.871056] LustreError: 36710:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff93dac5ef9000: can't stat MDS #0: rc = -19 [ 1549.004785] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1556.462158] LustreError: MGC192.168.206.117@tcp: Connection to MGS (at 192.168.206.117@tcp) was lost; in progress operations using this service will fail [ 1556.478134] Lustre: Evicted from MGS (at 192.168.206.117@tcp) after server handle changed from 0x7bce3d9e60309dcd to 0x7bce3d9e60309f86 [ 1556.495207] Lustre: MGC192.168.206.117@tcp: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 1557.550241] LustreError: lustre-MDT0000-mdc-ffff93dac5ef9000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1557.579522] Lustre: lustre-MDT0000-mdc-ffff93dac5ef9000: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 1564.202835] Lustre: DEBUG MARKER: Wait for df (36710) ... [ 1565.662962] Lustre: DEBUG MARKER: done [ 1568.113225] Lustre: Unmounted lustre-client [ 1595.769884] Key type lgssc unregistered [ 1596.043367] LNet: 37728:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1596.058644] LNetError: 37728:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1596.069555] LNet: Removed LNI 192.168.206.17@tcp [ 1596.639073] Key type .llcrypt unregistered [ 1596.640613] Key type ._llcrypt unregistered [ 1624.869153] Key type ._llcrypt registered [ 1624.875940] Key type .llcrypt registered [ 1626.430513] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 23:37:21 (1786419441) [ 1630.118047] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1630.377036] alg: No test for adler32 (adler32-zlib) [ 1631.647701] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 1632.028679] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 1633.800213] Key type lgssc registered [ 1635.649809] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1679.986588] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1685.236561] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1706.384389] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1709.041531] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 1713.454333] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-1023h38m49s [ 1715.227183] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1723.144521] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1725.779479] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1746.400149] Lustre: 41878:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786419543/real 1786419543] req@00000000dea335cb x1873196560161536/t0(0) o101->lustre-MDT0000-mdc-ffff93dae07f7000@192.168.206.117@tcp:12/10 lens 576/1152 e 0 to 1 dl 1786419563 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1746.433690] Lustre: lustre-MDT0000-mdc-ffff93dae07f7000: Connection to lustre-MDT0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1746.464575] Lustre: lustre-MDT0000-mdc-ffff93dae07f7000: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 1767.796790] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1770.636711] Lustre: DEBUG MARKER: done [ 1774.924913] Lustre: Unmounted lustre-client [ 1805.331148] Key type lgssc unregistered [ 1805.556864] LNet: 42760:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1805.575930] LNetError: 42760:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1805.596817] LNet: Removed LNI 192.168.206.17@tcp [ 1806.184554] Key type .llcrypt unregistered [ 1806.190381] Key type ._llcrypt unregistered [ 1838.642561] Key type ._llcrypt registered [ 1838.652314] Key type .llcrypt registered [ 1840.397476] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 23:40:55 (1786419655) [ 1842.173485] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1843.904261] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 23:40:59 (1786419659) [ 1847.374715] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1847.507535] alg: No test for adler32 (adler32-zlib) [ 1848.600000] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 1848.902535] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 1850.602259] Key type lgssc registered [ 1851.711078] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1878.761046] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 23:41:34 (1786419694) [ 1909.875636] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1915.505363] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1936.614835] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1939.286799] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 1943.066836] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1946.704038] Lustre: Unmounted lustre-client [ 1962.694535] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2008.186435] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2013.653389] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2014.202488] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 2018.275640] Lustre: Unmounted lustre-client [ 2072.927746] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2079.414371] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2080.055781] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 2084.327414] Lustre: Unmounted lustre-client [ 2100.470128] Lustre: DEBUG MARKER: files compared the same [ 2121.476040] Key type lgssc unregistered [ 2121.788724] LNet: 50375:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2121.794054] LNetError: 50375:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2121.811614] LNet: Removed LNI 192.168.206.17@tcp [ 2122.551437] Key type .llcrypt unregistered [ 2122.553527] Key type ._llcrypt unregistered [ 2136.408684] Key type ._llcrypt registered [ 2136.410826] Key type .llcrypt registered [ 2137.499787] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 23:45:53 (1786419953) [ 2139.269899] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2139.317474] alg: No test for adler32 (adler32-zlib) [ 2140.387774] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 2140.617087] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 2142.272169] Key type lgssc registered [ 2143.371835] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2192.628225] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2197.453635] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2215.468536] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2217.050451] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 2221.836763] Lustre: Unmounted lustre-client [ 2248.461641] Key type lgssc unregistered [ 2248.738637] LNet: 53955:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2248.757807] LNetError: 53955:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2248.778604] LNet: Removed LNI 192.168.206.17@tcp [ 2249.443725] Key type .llcrypt unregistered [ 2249.448616] Key type ._llcrypt unregistered [ 2265.002979] Key type ._llcrypt registered [ 2265.008250] Key type .llcrypt registered [ 2266.466163] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 23:48:01 (1786420081) [ 2269.298166] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2269.305638] alg: No test for adler32 (adler32-zlib) [ 2270.397271] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 2270.672831] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 2272.376151] Key type lgssc registered [ 2273.401405] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2356.336370] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2389.555397] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2395.971760] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2423.857978] Key type lgssc unregistered [ 2424.125781] LNet: 57445:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2424.135203] LNetError: 57445:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2424.158475] LNet: Removed LNI 192.168.206.17@tcp [ 2424.930866] Key type .llcrypt unregistered [ 2424.935663] Key type ._llcrypt unregistered [ 2439.130814] Key type ._llcrypt registered [ 2439.132969] Key type .llcrypt registered [ 2440.542510] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 23:50:56 (1786420256) [ 2443.977176] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2443.993881] alg: No test for adler32 (adler32-zlib) [ 2445.154558] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 2445.643323] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 2447.400798] Key type lgssc registered [ 2448.946474] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2518.658671] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 2525.795603] Lustre: Unmounted lustre-client [ 2558.317666] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 23:52:54 (1786420374) [ 2673.181283] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2688.302935] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 2695.246469] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2695.250969] LustreError: 63911:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff93dac8ada000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2695.274069] Lustre: 58428:0:(llite_lib.c:4356:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.117@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2705.640773] Lustre: Unmounted lustre-client [ 2769.670218] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 23:56:25 (1786420585) [ 2781.854698] Key type lgssc unregistered [ 2782.185468] LNet: 65131:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2782.194053] LNetError: 65131:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2782.218619] LNet: Removed LNI 192.168.206.17@tcp [ 2783.001584] Key type .llcrypt unregistered [ 2783.003505] Key type ._llcrypt unregistered [ 2795.990859] Key type ._llcrypt registered [ 2795.994493] Key type .llcrypt registered [ 2796.500783] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2796.518472] alg: No test for adler32 (adler32-zlib) [ 2797.659872] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 2797.993660] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 2799.785775] Key type lgssc registered [ 2801.061938] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2852.808759] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2858.606632] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2883.431401] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2885.133851] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 2892.700581] Lustre: Unmounted lustre-client [ 2928.315761] Key type lgssc unregistered [ 2928.641337] LNet: 68147:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2928.655851] LNetError: 68147:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2928.677550] LNet: Removed LNI 192.168.206.17@tcp [ 2929.439113] Key type .llcrypt unregistered [ 2929.443305] Key type ._llcrypt unregistered [ 2940.777078] Key type ._llcrypt registered [ 2940.795648] Key type .llcrypt registered [ 2941.048879] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2941.062838] alg: No test for adler32 (adler32-zlib) [ 2942.090857] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 2942.386735] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 2944.080248] Key type lgssc registered [ 2945.179636] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3050.798587] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3057.179724] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3080.742267] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3083.027175] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 3086.787516] Lustre: Unmounted lustre-client [ 3114.113490] Key type lgssc unregistered [ 3114.405434] LNet: 71594:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3114.444946] LNetError: 71594:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3114.468503] LNet: Removed LNI 192.168.206.17@tcp [ 3115.081687] Key type .llcrypt unregistered [ 3115.088551] Key type ._llcrypt unregistered [ 3130.896977] Key type ._llcrypt registered [ 3130.903029] Key type .llcrypt registered [ 3132.598085] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 00:02:27 (1786420947) [ 3135.799442] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3135.817303] alg: No test for adler32 (adler32-zlib) [ 3136.986429] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 3137.192095] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 3138.856419] Key type lgssc registered [ 3140.216433] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3195.482341] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3200.793961] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3224.706057] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3227.462910] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 3232.623698] Lustre: Unmounted lustre-client [ 3233.059537] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 3236.349684] Lustre: Unmounted lustre-client [ 3267.812244] Key type lgssc unregistered [ 3268.133068] LNet: 75287:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3268.148095] LNetError: 75287:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3268.183883] LNet: Removed LNI 192.168.206.17@tcp [ 3268.912319] Key type .llcrypt unregistered [ 3268.914068] Key type ._llcrypt unregistered [ 3281.083375] Key type ._llcrypt registered [ 3281.089095] Key type .llcrypt registered [ 3281.627684] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3281.642208] alg: No test for adler32 (adler32-zlib) [ 3282.728764] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 3283.006254] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 3284.696218] Key type lgssc registered [ 3285.908137] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3334.274756] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3340.979575] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3361.861544] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3363.481677] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 3371.334667] Lustre: Unmounted lustre-client [ 3405.619815] Key type lgssc unregistered [ 3405.897479] LNet: 78320:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3405.903630] LNetError: 78320:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3405.922259] LNet: Removed LNI 192.168.206.17@tcp [ 3406.528415] Key type .llcrypt unregistered [ 3406.531296] Key type ._llcrypt unregistered [ 3418.595842] Key type ._llcrypt registered [ 3418.600266] Key type .llcrypt registered [ 3419.845347] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 00:07:15 (1786421235) [ 3422.324268] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3422.366951] alg: No test for adler32 (adler32-zlib) [ 3423.566115] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 3423.821535] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 3425.456148] Key type lgssc registered [ 3426.513467] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3471.678077] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3476.195485] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3496.371952] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3498.100910] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 3505.392737] Lustre: lustre: root_squash is set to 0:0 [ 3512.351244] Lustre: lustre: nosquash_nids is cleared [ 3512.392444] Lustre: lustre: root_squash is set to 500:500 [ 3529.263693] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.17@tcp 192.168.0.[2,10]@tcp [ 3540.545787] Lustre: lustre: nosquash_nids set to 192.168.206.17/24@tcp [ 3547.763175] Lustre: Unmounted lustre-client [ 3574.902268] Key type lgssc unregistered [ 3575.169195] LNet: 82322:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3575.181389] LNetError: 82322:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3575.206628] LNet: Removed LNI 192.168.206.17@tcp [ 3575.974777] Key type .llcrypt unregistered [ 3575.977166] Key type ._llcrypt unregistered [ 3593.267435] Key type ._llcrypt registered [ 3593.269671] Key type .llcrypt registered [ 3594.721525] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 00:10:10 (1786421410) [ 3597.232819] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3598.541623] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 00:10:14 (1786421414) [ 3601.031019] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3601.058659] alg: No test for adler32 (adler32-zlib) [ 3602.221904] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 3602.636316] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 3604.472970] Key type lgssc registered [ 3606.268841] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3660.033540] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3665.618640] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3687.200822] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3688.889407] Lustre: lustre: root_squash is set to 500:500 [ 3688.915730] Lustre: lustre: nosquash_nids set to 192.168.206.17/24@tcp [ 3690.010860] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 3695.765415] Lustre: Unmounted lustre-client [ 3730.493711] Key type lgssc unregistered [ 3730.834225] LNet: 86300:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3730.840542] LNetError: 86300:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3730.854962] LNet: Removed LNI 192.168.206.17@tcp [ 3731.573578] Key type .llcrypt unregistered [ 3731.578432] Key type ._llcrypt unregistered [ 3746.058665] Key type ._llcrypt registered [ 3746.061494] Key type .llcrypt registered [ 3747.250590] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3748.741652] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 00:12:44 (1786421564) [ 3765.894599] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3765.916289] alg: No test for adler32 (adler32-zlib) [ 3766.980407] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 3767.226923] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 3768.888169] Key type lgssc registered [ 3769.922968] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3848.918692] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3855.376768] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3878.864036] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3953.064242] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3958.931682] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3979.289700] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3991.279429] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 4023.700977] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff93dae07f6000.ost_server_uuid 50 [ 4025.314918] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff93dae07f6000.ost_server_uuid in IDLE state after 0 sec [ 4025.913100] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 4030.548744] Lustre: Unmounted lustre-client [ 4032.626738] Lustre: Unmounted lustre-client [ 4089.358693] Key type lgssc unregistered [ 4089.583714] LNet: 93978:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4089.594612] LNetError: 93978:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4089.620619] LNet: Removed LNI 192.168.206.17@tcp [ 4090.285130] Key type .llcrypt unregistered [ 4090.287263] Key type ._llcrypt unregistered [ 4119.971163] Key type ._llcrypt registered [ 4119.973455] Key type .llcrypt registered [ 4121.416969] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 00:18:56 (1786421936) [ 4139.618286] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4139.671395] alg: No test for adler32 (adler32-zlib) [ 4140.829604] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 4141.081681] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 4142.720249] Key type lgssc registered [ 4144.116798] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4227.604395] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4232.542724] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4254.951874] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4257.814940] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 4278.243806] Lustre: 95363:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786422079/real 1786422079] req@00000000300c1f26 x1873199191037184/t0(0) o400->lustre-OST0000-osc-ffff93dae0654000@192.168.206.117@tcp:28/4 lens 224/224 e 0 to 1 dl 1786422095 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4278.267838] Lustre: lustre-OST0000-osc-ffff93dae0654000: Connection to lustre-OST0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4284.384364] Lustre: 95363:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786422085/real 1786422085] req@00000000d92f86dd x1873199191037696/t0(0) o400->lustre-OST0000-osc-ffff93dae0654000@192.168.206.117@tcp:28/4 lens 224/224 e 0 to 1 dl 1786422101 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4286.383836] Lustre: lustre-OST0000-osc-ffff93dae0654000: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 4287.456839] Lustre: 95363:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786422088/real 1786422088] req@000000001b4dca01 x1873199191038208/t0(0) o400->lustre-OST0000-osc-ffff93dae0654000@192.168.206.117@tcp:28/4 lens 224/224 e 0 to 1 dl 1786422104 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4288.498137] Lustre: lustre-MDT0000-mdc-ffff93dae0654000: Connection to lustre-MDT0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4292.576200] Lustre: 95363:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786422093/real 1786422093] req@000000003c9e514c x1873199191038720/t0(0) o400->lustre-OST0000-osc-ffff93dae0654000@192.168.206.117@tcp:28/4 lens 224/224 e 0 to 1 dl 1786422109 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4304.864324] Lustre: 95362:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786422105/real 1786422105] req@00000000d583d408 x1873199191040384/t0(0) o400->MGC192.168.206.117@tcp@192.168.206.117@tcp:26/25 lens 224/224 e 0 to 1 dl 1786422121 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4304.898847] LustreError: MGC192.168.206.117@tcp: Connection to MGS (at 192.168.206.117@tcp) was lost; in progress operations using this service will fail [ 4313.203712] Lustre: lustre-MDT0000-mdc-ffff93dae0654000: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 4315.172727] Lustre: Evicted from MGS (at 192.168.206.117@tcp) after server handle changed from 0x94d352d52c91f162 to 0x94d352d52c91f4e2 [ 4315.194311] Lustre: MGC192.168.206.117@tcp: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 4319.647647] Lustre: Unmounted lustre-client [ 4346.894378] Key type lgssc unregistered [ 4347.159860] LNet: 99667:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4347.164073] LNetError: 99667:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4347.179671] LNet: Removed LNI 192.168.206.17@tcp [ 4347.870674] Key type .llcrypt unregistered [ 4347.876097] Key type ._llcrypt unregistered [ 4362.974946] Key type ._llcrypt registered [ 4362.976716] Key type .llcrypt registered [ 4364.113641] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 00:22:59 (1786422179) [ 4379.197953] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4379.232594] alg: No test for adler32 (adler32-zlib) [ 4380.393808] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 4380.562074] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 4382.328246] Key type lgssc registered [ 4383.354460] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4421.071078] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4517.410463] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4524.188201] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4548.550238] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4550.215967] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 4552.311311] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4554.167182] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 00:26:09 (1786422369) [ 4789.845748] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4800.229091] Lustre: Unmounted lustre-client [ 4914.870285] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4921.805696] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4946.180069] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4990.641514] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 00:33:25 (1786422805) [ 5086.911026] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5093.126444] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5116.967541] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5117.578611] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 5121.613851] Lustre: Unmounted lustre-client [ 5155.046409] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 00:36:10 (1786422970) [ 5250.526373] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5257.133767] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5282.330192] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5282.999729] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 5287.096804] Lustre: Unmounted lustre-client [ 5323.628621] Key type lgssc unregistered [ 5323.911825] LNet: 122700:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5323.922478] LNetError: 122700:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5323.948489] LNet: Removed LNI 192.168.206.17@tcp [ 5324.587452] Key type .llcrypt unregistered [ 5324.589360] Key type ._llcrypt unregistered [ 5339.287698] Key type ._llcrypt registered [ 5339.291303] Key type .llcrypt registered [ 5340.646300] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 00:39:16 (1786423156) [ 5342.970529] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5343.003585] alg: No test for adler32 (adler32-zlib) [ 5344.063461] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 5344.272373] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 5345.952347] Key type lgssc registered [ 5347.190928] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5399.329506] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5405.139354] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5427.650043] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5430.486413] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 5447.739377] Lustre: Unmounted lustre-client [ 5476.194290] Key type lgssc unregistered [ 5476.486355] LNet: 126306:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5476.498778] LNetError: 126306:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5476.532872] LNet: Removed LNI 192.168.206.17@tcp [ 5477.296935] Key type .llcrypt unregistered [ 5477.305606] Key type ._llcrypt unregistered [ 5491.332434] Key type ._llcrypt registered [ 5491.334996] Key type .llcrypt registered [ 5492.396721] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 00:41:48 (1786423308) [ 5494.581827] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5494.787034] alg: No test for adler32 (adler32-zlib) [ 5495.831421] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 5496.034688] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 5497.713800] Key type lgssc registered [ 5498.928783] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5545.622460] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5551.515527] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5571.291878] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5573.163413] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 5578.216111] Lustre: lustre-OST0000-osc-ffff93dac5c46800: Connection to lustre-OST0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5588.944560] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff93dac5c46800.ost_server_uuid 50 [ 5590.485753] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5601.655485] Lustre: Unmounted lustre-client [ 5623.032950] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 00:43:58 (1786423438) [ 5659.402981] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5665.697497] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5690.538886] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5714.611108] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5715.338428] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 5720.582114] Lustre: lustre-OST0000-osc-ffff93dac749b000: Connection to lustre-OST0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5747.116890] Lustre: Unmounted lustre-client [ 5794.136809] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 00:46:50 (1786423610) [ 5828.873344] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5834.231495] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5856.695466] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5876.065614] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5876.682378] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 5881.835632] Lustre: lustre-OST0000-osc-ffff93dac685c000: Connection to lustre-OST0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5898.341036] Lustre: Unmounted lustre-client [ 5943.328652] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 00:49:18 (1786423758) [ 6034.427965] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6039.875840] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6061.106880] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6141.161277] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6147.588900] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6171.987271] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6212.901990] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 6254.469690] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6259.081583] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 6261.645547] Lustre: Unmounted lustre-client [ 6295.791959] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 00:55:11 (1786424111) [ 6329.811259] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6335.239644] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6355.548953] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6387.876708] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6417.694319] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 6458.187812] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6459.408526] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6463.981305] Lustre: lustre-OST0001-osc-ffff93dac8ea5800: Connection to lustre-OST0001 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6472.253249] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6482.581296] Lustre: Unmounted lustre-client [ 6528.173910] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 00:59:04 (1786424344) [ 6554.780368] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6559.891252] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6579.651545] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6580.472835] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 6602.266289] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6603.737718] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6621.212937] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff93dad804a000.ost_server_uuid 50 [ 6622.496531] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff93dad804a000.ost_server_uuid in IDLE state after 0 sec [ 6625.058609] Lustre: Unmounted lustre-client [ 6625.297964] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6625.303457] Lustre: Skipped 3 previous similar messages [ 6625.414949] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 6626.426827] LustreError: 149753:0:(sec.c:403:import_sec_validate_get()) import 00000000219e8497 (NEW) with no sec [ 6677.190760] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 01:01:33 (1786424493) [ 6709.691521] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6715.953028] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6736.741948] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6755.520573] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6756.126906] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6756.276070] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 6770.918837] Lustre: Unmounted lustre-client [ 6770.922328] Lustre: Skipped 1 previous similar message [ 6807.869989] Key type lgssc unregistered [ 6808.071187] LNet: 153185:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6808.076548] LNetError: 153185:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6808.107271] LNet: Removed LNI 192.168.206.17@tcp [ 6808.666067] Key type .llcrypt unregistered [ 6808.668354] Key type ._llcrypt unregistered [ 6825.200424] Key type ._llcrypt registered [ 6825.202668] Key type .llcrypt registered [ 6826.644236] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 01:04:02 (1786424642) [ 6827.635285] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6827.705590] alg: No test for adler32 (adler32-zlib) [ 6828.721245] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 6828.930488] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 6830.608205] Key type lgssc registered [ 6831.736649] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6881.156650] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6886.738599] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6907.539457] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6927.817509] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6929.321616] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6930.524233] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 6933.275870] LustreError: lustre-MDT0001-mdc-ffff93dac4801800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6933.312587] Lustre: lustre-MDT0001-mdc-ffff93dac4801800: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 6939.071924] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6940.692260] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 6963.219690] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6967.200497] Lustre: Unmounted lustre-client [ 6993.116794] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 01:06:48 (1786424808) [ 7089.283611] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7095.348782] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7121.981319] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7122.602833] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 7149.302717] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7151.705274] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7164.176493] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7174.532826] Lustre: Unmounted lustre-client [ 7206.795645] Key type lgssc unregistered [ 7207.123831] LNet: 162762:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7207.129310] LNetError: 162762:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7207.141569] LNet: Removed LNI 192.168.206.17@tcp [ 7207.889261] Key type .llcrypt unregistered [ 7207.891547] Key type ._llcrypt unregistered [ 7236.961536] Key type ._llcrypt registered [ 7236.977639] Key type .llcrypt registered [ 7238.615642] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 01:10:53 (1786425053) [ 7241.159308] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7241.191384] alg: No test for adler32 (adler32-zlib) [ 7242.431283] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 7242.832232] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 7244.561345] Key type lgssc registered [ 7246.458599] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7293.306597] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7298.909445] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7318.134770] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7319.725928] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 7366.004143] Lustre: Unmounted lustre-client [ 7405.658030] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7406.265754] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 7442.465513] Lustre: Unmounted lustre-client [ 7470.447840] Key type lgssc unregistered [ 7470.727144] LNet: 167209:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7470.733765] LNetError: 167209:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7470.746783] LNet: Removed LNI 192.168.206.17@tcp [ 7471.471455] Key type .llcrypt unregistered [ 7471.475249] Key type ._llcrypt unregistered [ 7485.974907] Key type ._llcrypt registered [ 7485.977882] Key type .llcrypt registered [ 7487.315055] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 01:15:02 (1786425302) [ 7489.236256] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7489.256080] alg: No test for adler32 (adler32-zlib) [ 7490.337284] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 7490.605790] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 7492.312636] Key type lgssc registered [ 7493.844242] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7544.779139] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7550.552355] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7571.332584] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7574.232954] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 7595.394259] Lustre: Unmounted lustre-client [ 7623.172836] Key type lgssc unregistered [ 7623.472912] LNet: 170967:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7623.478964] LNetError: 170967:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7623.497750] LNet: Removed LNI 192.168.206.17@tcp [ 7624.293848] Key type .llcrypt unregistered [ 7624.296206] Key type ._llcrypt unregistered [ 7637.690312] Key type ._llcrypt registered [ 7637.694648] Key type .llcrypt registered [ 7638.315238] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7638.340816] alg: No test for adler32 (adler32-zlib) [ 7639.542679] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 7639.958746] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 7641.728519] Key type lgssc registered [ 7643.313215] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7700.632802] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7707.079286] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7727.360338] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7729.991296] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 7740.378087] Lustre: Unmounted lustre-client [ 7766.324793] Key type lgssc unregistered [ 7766.545974] LNet: 174031:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7766.552078] LNetError: 174031:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7766.568502] LNet: Removed LNI 192.168.206.17@tcp [ 7767.384053] Key type .llcrypt unregistered [ 7767.386332] Key type ._llcrypt unregistered [ 7783.559498] Key type ._llcrypt registered [ 7783.562648] Key type .llcrypt registered [ 7785.351362] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 01:20:00 (1786425600) [ 7788.708476] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7788.728976] alg: No test for adler32 (adler32-zlib) [ 7789.902722] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 7790.085728] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 7791.736655] Key type lgssc registered [ 7793.052697] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7841.610861] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7847.556107] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7868.726648] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7871.557275] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 7893.843198] Lustre: Unmounted lustre-client [ 7920.359299] Key type lgssc unregistered [ 7920.661712] LNet: 177787:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7920.669435] LNetError: 177787:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7920.679810] LNet: Removed LNI 192.168.206.17@tcp [ 7921.448919] Key type .llcrypt unregistered [ 7921.451302] Key type ._llcrypt unregistered [ 7933.341687] Key type ._llcrypt registered [ 7933.350868] Key type .llcrypt registered [ 7933.744609] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7933.761318] alg: No test for adler32 (adler32-zlib) [ 7934.857192] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 7935.095134] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 7936.761102] Key type lgssc registered [ 7938.032629] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7988.440329] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7994.218939] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8012.608310] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8014.292446] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 8021.857607] Lustre: Unmounted lustre-client [ 8050.844794] Key type lgssc unregistered [ 8051.159727] LNet: 180852:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8051.170471] LNetError: 180852:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8051.201403] LNet: Removed LNI 192.168.206.17@tcp [ 8052.128299] Key type .llcrypt unregistered [ 8052.137967] Key type ._llcrypt unregistered [ 8068.003378] Key type ._llcrypt registered [ 8068.015899] Key type .llcrypt registered [ 8069.323630] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 01:24:44 (1786425884) [ 8093.284432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8093.362702] alg: No test for adler32 (adler32-zlib) [ 8094.514126] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 8094.757528] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 8096.480379] Key type lgssc registered [ 8097.928965] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8183.703990] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8190.722657] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8214.699808] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8258.222987] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 01:27:53 (1786426073) [ 8293.731504] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8299.469078] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8321.318661] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8324.169409] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 8332.818778] Lustre: Unmounted lustre-client [ 8369.735385] Key type lgssc unregistered [ 8370.083438] LNet: 187954:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8370.101746] LNetError: 187954:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8370.133653] LNet: Removed LNI 192.168.206.17@tcp [ 8371.035185] Key type .llcrypt unregistered [ 8371.039651] Key type ._llcrypt unregistered [ 8387.340601] Key type ._llcrypt registered [ 8387.346172] Key type .llcrypt registered [ 8388.790995] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8390.691249] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 01:30:06 (1786426206) [ 8408.167494] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8408.244351] alg: No test for adler32 (adler32-zlib) [ 8409.336904] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 8409.696232] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 8411.360965] Key type lgssc registered [ 8412.612489] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8499.541705] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8505.330200] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8528.268657] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8549.528265] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8552.203480] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 8575.357189] Lustre: Unmounted lustre-client [ 8713.182607] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8719.981602] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8743.847853] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8782.792656] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 01:36:38 (1786426598) [ 8784.230732] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8785.792940] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 01:36:41 (1786426601) [ 8874.395914] Key type lgssc unregistered [ 8874.632220] LNet: 199399:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8874.643724] LNetError: 199399:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8874.666487] LNet: Removed LNI 192.168.206.17@tcp [ 8875.253116] Key type .llcrypt unregistered [ 8875.254861] Key type ._llcrypt unregistered [ 8888.499817] Key type ._llcrypt registered [ 8888.505913] Key type .llcrypt registered [ 8889.993708] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 01:38:25 (1786426705) [ 8934.060519] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8934.070789] alg: No test for adler32 (adler32-zlib) [ 8935.179233] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 8935.389115] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 8937.016248] Key type lgssc registered [ 8938.014888] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8982.339567] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8989.045337] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9023.299091] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9049.477922] Key type lgssc unregistered [ 9049.713822] LNet: 203134:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9049.719823] LNetError: 203134:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9049.742353] LNet: Removed LNI 192.168.206.17@tcp [ 9050.435732] Key type .llcrypt unregistered [ 9050.437454] Key type ._llcrypt unregistered [ 9064.524807] Key type ._llcrypt registered [ 9064.527476] Key type .llcrypt registered [ 9065.679202] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 01:41:21 (1786426881) [ 9068.213069] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9068.253878] alg: No test for adler32 (adler32-zlib) [ 9069.308987] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 9069.545443] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 9071.200220] Key type lgssc registered [ 9072.204806] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9121.426444] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9127.518986] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9150.098372] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9152.841564] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 9163.245396] Lustre: lustre-MDT0000-mdc-ffff93dac8ea5800: Connection to lustre-MDT0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9173.478400] Lustre: lustre-MDT0001-mdc-ffff93dac8ea5800: Connection to lustre-MDT0001 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9184.736486] Lustre: 204123:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786426985/real 1786426985] req@0000000078da7659 x1873204358496512/t0(0) o400->MGC192.168.206.117@tcp@192.168.206.117@tcp:26/25 lens 224/224 e 0 to 1 dl 1786427001 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9184.768474] LustreError: MGC192.168.206.117@tcp: Connection to MGS (at 192.168.206.117@tcp) was lost; in progress operations using this service will fail [ 9194.028726] Lustre: Evicted from MGS (at 192.168.206.117@tcp) after server handle changed from 0xbe2fe352bef77875 to 0xbe2fe352bef79348 [ 9194.050308] Lustre: MGC192.168.206.117@tcp: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 9218.542708] LustreError: lustre-MDT0000-mdc-ffff93dac8ea5800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9218.580865] Lustre: lustre-MDT0000-mdc-ffff93dac8ea5800: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 9222.663477] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9224.266402] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9229.621441] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9230.983522] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9234.467876] Lustre: Unmounted lustre-client [ 9261.772455] Key type lgssc unregistered [ 9262.003545] LNet: 208082:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9262.012416] LNetError: 208082:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9262.027761] LNet: Removed LNI 192.168.206.17@tcp [ 9262.746535] Key type .llcrypt unregistered [ 9262.749315] Key type ._llcrypt unregistered [ 9276.282316] Key type ._llcrypt registered [ 9276.284516] Key type .llcrypt registered [ 9277.441083] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 01:44:53 (1786427093) [ 9279.810986] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9279.827092] alg: No test for adler32 (adler32-zlib) [ 9281.020460] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 9281.248362] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 9282.912461] Key type lgssc registered [ 9283.928363] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9333.592837] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9339.507490] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9394.048367] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9399.361783] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9444.593352] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9472.426612] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9522.857712] Key type lgssc unregistered [ 9523.196562] LNet: 213383:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9523.205531] LNetError: 213383:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9523.225269] LNet: Removed LNI 192.168.206.17@tcp [ 9524.164909] Key type .llcrypt unregistered [ 9524.173233] Key type ._llcrypt unregistered [ 9576.459208] Key type ._llcrypt registered [ 9576.462515] Key type .llcrypt registered [ 9578.240933] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 01:49:53 (1786427393) [ 9624.802661] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9624.822209] alg: No test for adler32 (adler32-zlib) [ 9625.990306] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [ 9626.331019] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [ 9627.976216] Key type lgssc registered [ 9629.320116] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9726.141548] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9733.461290] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9757.192518] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9800.564278] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 01:53:36 (1786427616) [ 9809.290926] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 01:53:44 (1786427624) [ 9846.690790] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9852.758296] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9875.297852] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9876.925207] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [ 9885.686685] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9887.705773] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9889.440482] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9891.202790] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9897.456055] Lustre: lustre-MDT0000-mdc-ffff93dad0bfc800: Connection to lustre-MDT0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9913.824842] Lustre: 215280:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786427714/real 1786427714] req@0000000083d5ac01 x1873204942481664/t0(0) o400->MGC192.168.206.117@tcp@192.168.206.117@tcp:26/25 lens 224/224 e 0 to 1 dl 1786427730 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9913.845554] LustreError: MGC192.168.206.117@tcp: Connection to MGS (at 192.168.206.117@tcp) was lost; in progress operations using this service will fail [ 9918.955350] Lustre: Evicted from MGS (at 192.168.206.117@tcp) after server handle changed from 0x8c6be64e065e4d48 to 0x8c6be64e065e4ec2 [ 9918.977697] Lustre: MGC192.168.206.117@tcp: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 9926.805491] Lustre: lustre-MDT0000-mdc-ffff93dad0bfc800: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 9935.636808] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9937.149979] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9940.549291] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9944.554582] Lustre: lustre-MDT0000-mdc-ffff93dad0bfc800: Connection to lustre-MDT0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9960.800277] Lustre: 215282:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786427761/real 1786427761] req@00000000a50a676b x1873204942490496/t0(0) o400->MGC192.168.206.117@tcp@192.168.206.117@tcp:26/25 lens 224/224 e 0 to 1 dl 1786427777 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9960.824828] LustreError: MGC192.168.206.117@tcp: Connection to MGS (at 192.168.206.117@tcp) was lost; in progress operations using this service will fail [ 9970.158996] Lustre: Evicted from MGS (at 192.168.206.117@tcp) after server handle changed from 0x8c6be64e065e4ec2 to 0x8c6be64e065e51d2 [ 9970.171193] Lustre: MGC192.168.206.117@tcp: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 9978.532799] Lustre: lustre-MDT0000-mdc-ffff93dad0bfc800: Connection restored to 192.168.206.117@tcp (at 192.168.206.117@tcp) [ 9987.501387] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9989.215207] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9993.366928] Lustre: Unmounted lustre-client [10074.853808] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10082.065412] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10109.407355] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10115.662962] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [10117.943347] Lustre: Unmounted lustre-client [10141.566632] Key type lgssc unregistered [10141.861857] LNet: 225866:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10141.872223] LNetError: 225866:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10141.902549] LNet: Removed LNI 192.168.206.17@tcp [10142.543620] Key type .llcrypt unregistered [10142.547974] Key type ._llcrypt unregistered [10158.764935] Key type ._llcrypt registered [10158.766790] Key type .llcrypt registered [10160.191514] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 01:59:35 (1786427975) [10165.272087] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10165.293065] alg: No test for adler32 (adler32-zlib) [10166.481944] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [10166.726571] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [10168.440197] Key type lgssc registered [10170.000872] Lustre: Echo OBD driver; http://www.lustre.org/ [10222.221519] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10227.152922] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10247.693545] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10250.372339] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [10257.094141] Lustre: Unmounted lustre-client [10323.689272] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10330.112246] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10351.100871] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10351.587515] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [10359.588199] Lustre: Unmounted lustre-client [10420.693313] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10426.056632] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10447.147377] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10448.101674] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [10450.608597] Lustre: Unmounted lustre-client [10480.784779] Key type lgssc unregistered [10481.141967] LNet: 232925:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10481.153835] LNetError: 232925:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10481.190099] LNet: Removed LNI 192.168.206.17@tcp [10482.223356] Key type .llcrypt unregistered [10482.227413] Key type ._llcrypt unregistered [10503.267129] Key type ._llcrypt registered [10503.274278] Key type .llcrypt registered [10504.888703] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 02:05:20 (1786428320) [10508.423486] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10508.439555] alg: No test for adler32 (adler32-zlib) [10509.759778] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [10510.030676] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [10511.768183] Key type lgssc registered [10513.101977] Lustre: Echo OBD driver; http://www.lustre.org/ [10556.773569] Key type lgssc unregistered [10557.057939] LNet: 235252:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10557.077551] LNetError: 235252:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10557.114735] LNet: Removed LNI 192.168.206.17@tcp [10557.958616] Key type .llcrypt unregistered [10557.960988] Key type ._llcrypt unregistered [10589.178916] Key type ._llcrypt registered [10589.183149] Key type .llcrypt registered [10589.840495] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10589.860079] alg: No test for adler32 (adler32-zlib) [10590.992671] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [10591.344082] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [10593.145619] Key type lgssc registered [10594.870319] Lustre: Echo OBD driver; http://www.lustre.org/ [10675.928527] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10683.524642] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10708.883993] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10751.346382] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10753.059898] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 02:09:28 (1786428568) [10784.586673] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10790.111044] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10811.334957] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10834.819686] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10836.555252] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [10841.586278] Lustre: lustre-OST0001-osc-ffff93dad0bf9000: Connection to lustre-OST0001 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [10850.214171] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10860.584061] Lustre: Unmounted lustre-client [10897.929730] Key type lgssc unregistered [10898.322043] LNet: 242365:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10898.327924] LNetError: 242365:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10898.361624] LNet: Removed LNI 192.168.206.17@tcp [10899.083704] Key type .llcrypt unregistered [10899.086296] Key type ._llcrypt unregistered [10932.634732] Key type ._llcrypt registered [10932.636608] Key type .llcrypt registered [10934.115167] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 02:12:29 (1786428749) [10949.207789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10949.228244] alg: No test for adler32 (adler32-zlib) [10950.371869] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [10950.616478] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [10952.360507] Key type lgssc registered [10953.730602] Lustre: Echo OBD driver; http://www.lustre.org/ [11006.143935] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11013.107294] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11035.048874] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 02:14:10 (1786428850) [11069.613791] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11075.699704] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11099.306473] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11102.021031] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [11109.408988] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11117.764114] Lustre: Unmounted lustre-client [11222.301541] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11227.998694] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11283.656593] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11284.554124] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [11288.641398] Lustre: Unmounted lustre-client [11317.568366] Key type lgssc unregistered [11317.808744] LNet: 250066:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11317.824637] LNetError: 250066:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11317.851924] LNet: Removed LNI 192.168.206.17@tcp [11318.881106] Key type .llcrypt unregistered [11318.887946] Key type ._llcrypt unregistered [11352.695221] Key type ._llcrypt registered [11352.697674] Key type .llcrypt registered [11353.027116] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11353.039761] alg: No test for adler32 (adler32-zlib) [11354.268772] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [11354.641293] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [11356.410849] Key type lgssc registered [11357.557727] Lustre: Echo OBD driver; http://www.lustre.org/ [11437.712969] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11443.167603] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11463.554175] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11502.303279] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11504.274488] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 02:21:59 (1786429319) [11534.006629] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11539.260918] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11557.363861] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11560.961495] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [11565.025487] Lustre: Unmounted lustre-client [11592.531556] Key type lgssc unregistered [11592.812172] LNet: 256699:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11592.816490] LNetError: 256699:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11592.838043] LNet: Removed LNI 192.168.206.17@tcp [11593.475522] Key type .llcrypt unregistered [11593.479130] Key type ._llcrypt unregistered [11606.575549] Key type ._llcrypt registered [11606.577318] Key type .llcrypt registered [11608.144895] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11609.988761] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 02:23:45 (1786429425) [11617.511475] Key type .llcrypt unregistered [11617.515655] Key type ._llcrypt unregistered [11625.584299] Key type ._llcrypt registered [11625.586589] Key type .llcrypt registered [11626.000303] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11626.021533] alg: No test for adler32 (adler32-zlib) [11627.080897] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [11627.321312] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [11628.992347] Key type lgssc registered [11630.569868] Lustre: Echo OBD driver; http://www.lustre.org/ [11682.857641] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11697.879917] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [11700.911136] Lustre: Unmounted lustre-client [11728.540568] Key type lgssc unregistered [11728.829328] LNet: 260154:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11728.844034] LNetError: 260154:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11729.897260] LNet: Removed LNI 192.168.206.17@tcp [11730.570654] Key type .llcrypt unregistered [11730.573988] Key type ._llcrypt unregistered [11747.483571] Key type ._llcrypt registered [11747.486764] Key type .llcrypt registered [11748.930716] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 02:26:04 (1786429564) [11751.955041] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11751.999511] alg: No test for adler32 (adler32-zlib) [11753.234457] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [11753.576079] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [11755.288491] Key type lgssc registered [11756.783779] Lustre: Echo OBD driver; http://www.lustre.org/ [11841.399625] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11871.342446] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11876.710510] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11879.598055] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [11882.309037] Lustre: Unmounted lustre-client [11905.280949] Key type lgssc unregistered [11905.539051] LNet: 263696:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11905.552390] LNetError: 263696:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11905.590381] LNet: Removed LNI 192.168.206.17@tcp [11906.320880] Key type .llcrypt unregistered [11906.325544] Key type ._llcrypt unregistered [11922.820594] Key type ._llcrypt registered [11922.829467] Key type .llcrypt registered [11924.146923] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 02:28:59 (1786429739) [11926.800020] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11926.812108] alg: No test for adler32 (adler32-zlib) [11927.883406] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [11928.115273] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [11929.816349] Key type lgssc registered [11931.057748] Lustre: Echo OBD driver; http://www.lustre.org/ [11980.110046] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11985.969417] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12004.827902] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12007.682184] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [12013.034936] Lustre: lustre-MDT0000-mdc-ffff93dae027f000: Connection to lustre-MDT0000 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [12017.709139] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12017.737720] LustreError: 266852:0:(file.c:6154:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12018.171786] LustreError: MGC192.168.206.117@tcp: Connection to MGS (at 192.168.206.117@tcp) was lost; in progress operations using this service will fail [12018.238112] Lustre: Unmounted lustre-client [12038.482388] Key type lgssc unregistered [12038.768689] LNet: 267266:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12038.773979] LNetError: 267266:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12039.846458] LNet: Removed LNI 192.168.206.17@tcp [12040.448263] Key type .llcrypt unregistered [12040.453667] Key type ._llcrypt unregistered [12056.847719] Key type ._llcrypt registered [12056.853152] Key type .llcrypt registered [12058.174678] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 02:31:13 (1786429873) [12060.182845] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12060.238229] alg: No test for adler32 (adler32-zlib) [12061.269915] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [12061.467529] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [12063.128199] Key type lgssc registered [12064.378296] Lustre: Echo OBD driver; http://www.lustre.org/ [12111.156229] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12117.068312] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12137.409982] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12140.291960] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [12145.639479] Lustre: lustre-MDT0001-mdc-ffff93dac6d91000: Connection to lustre-MDT0001 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [12150.726103] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12153.409202] Lustre: Unmounted lustre-client [12171.224462] Key type lgssc unregistered [12171.487385] LNet: 270846:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12171.498355] LNetError: 270846:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12171.513910] LNet: Removed LNI 192.168.206.17@tcp [12172.224275] Key type .llcrypt unregistered [12172.226993] Key type ._llcrypt unregistered [12187.443282] Key type ._llcrypt registered [12187.448262] Key type .llcrypt registered [12188.914258] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 02:33:24 (1786430004) [12207.800407] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12207.927029] alg: No test for adler32 (adler32-zlib) [12209.133714] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [12209.445972] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [12211.169509] Key type lgssc registered [12212.373333] Lustre: Echo OBD driver; http://www.lustre.org/ [12311.974723] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12314.636790] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [12355.558566] Lustre: lustre-MDT0001-mdc-ffff93dae0d8f800: Connection to lustre-MDT0001 (at 192.168.206.117@tcp) was lost; in progress operations using this service will wait for recovery to complete [12365.153820] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12375.483287] Lustre: Unmounted lustre-client [12400.987700] Key type lgssc unregistered [12401.240392] LNet: 276641:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12401.253842] LNetError: 276641:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12401.290407] LNet: Removed LNI 192.168.206.17@tcp [12402.025422] Key type .llcrypt unregistered [12402.031337] Key type ._llcrypt unregistered [12416.545291] Key type ._llcrypt registered [12416.547227] Key type .llcrypt registered [12418.009467] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 02:37:13 (1786430233) [12419.883665] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12421.710373] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 02:37:17 (1786430237) [12423.421602] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12425.268928] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 02:37:20 (1786430240) [12427.035517] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12429.185328] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 02:37:24 (1786430244) [12430.889811] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12432.340093] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 02:37:28 (1786430248) [12433.947913] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12435.704252] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 02:37:31 (1786430251) [12444.202551] Key type .llcrypt unregistered [12444.204369] Key type ._llcrypt unregistered [12450.788481] Key type ._llcrypt registered [12450.809123] Key type .llcrypt registered [12451.059147] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12451.094437] alg: No test for adler32 (adler32-zlib) [12452.145188] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [12452.398910] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [12454.080164] Key type lgssc registered [12455.463238] Lustre: Echo OBD driver; http://www.lustre.org/ [12526.591459] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12532.404133] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12554.887851] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12556.465536] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [12559.823618] Lustre: Unmounted lustre-client [12596.531650] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 02:40:12 (1786430412) [12629.840027] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12637.131767] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12668.880392] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12679.793873] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [12682.190850] Lustre: Unmounted lustre-client [12729.700556] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 02:42:25 (1786430545) [12729.888609] LNet: 1 local NIs in recovery (showing 1): 192.168.206.17@tcp [13372.951775] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13378.651828] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13415.664359] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13510.776644] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 02:55:26 (1786431326) [13521.464716] Key type lgssc unregistered [13521.714092] LNet: 290168:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13521.736170] LNetError: 290168:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13522.795149] LNet: Removed LNI 192.168.206.17@tcp [13523.424683] Key type .llcrypt unregistered [13523.426507] Key type ._llcrypt unregistered [13663.577484] Key type ._llcrypt registered [13663.582355] Key type .llcrypt registered [13664.107154] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13664.121887] alg: No test for adler32 (adler32-zlib) [13665.282604] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [13665.568846] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [13667.240224] Key type lgssc registered [13668.298767] Lustre: Echo OBD driver; http://www.lustre.org/ [13750.776441] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13755.916512] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13775.855930] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13806.962809] Key type lgssc unregistered [13807.256672] LNet: 293866:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13807.264187] LNetError: 293866:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13807.305622] LNet: Removed LNI 192.168.206.17@tcp [13807.905742] Key type .llcrypt unregistered [13807.910551] Key type ._llcrypt unregistered [13842.546549] Key type ._llcrypt registered [13842.549968] Key type .llcrypt registered [13844.412178] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 03:00:59 (1786431659) [13866.680786] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13866.752467] alg: No test for adler32 (adler32-zlib) [13867.824492] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [13868.061959] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [13869.745541] Key type lgssc registered [13870.993724] Lustre: Echo OBD driver; http://www.lustre.org/ [13919.376539] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 03:02:15 (1786431735) [13930.553774] Key type lgssc unregistered [13930.784767] LNet: 297447:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13930.800513] LNetError: 297447:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13930.824305] LNet: Removed LNI 192.168.206.17@tcp [13931.636974] Key type .llcrypt unregistered [13931.639078] Key type ._llcrypt unregistered [13941.074587] Key type ._llcrypt registered [13941.076766] Key type .llcrypt registered [13941.418244] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13941.441634] alg: No test for adler32 (adler32-zlib) [13942.540527] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [13942.765654] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [13944.400217] Key type lgssc registered [13945.485531] Lustre: Echo OBD driver; http://www.lustre.org/ [13995.594634] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14001.166616] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14022.080468] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14278.237558] LNet: Added LNI 192.168.206.17@tcp50 [8/256/0/180] [14280.474395] LNet: Removed LNI 192.168.206.17@tcp [14282.489537] Lustre: 301837:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff93dac7785000: config has no valid NIDs, force dynamic NIDs [14283.801679] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [14283.970651] Lustre: Unmounted lustre-client [14286.696519] Key type lgssc unregistered [14287.089786] LNet: 302098:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14287.099366] LNetError: 302098:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14287.112665] LNet: Removed LNI 192.168.206.17@tcp50 [14287.671548] Key type .llcrypt unregistered [14287.673843] Key type ._llcrypt unregistered [14304.639695] Key type ._llcrypt registered [14304.644334] Key type .llcrypt registered [14305.076424] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14305.087994] alg: No test for adler32 (adler32-zlib) [14306.211632] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [14306.414158] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [14308.120424] Key type lgssc registered [14309.162740] Lustre: Echo OBD driver; http://www.lustre.org/ [14366.716779] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14372.268265] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14380.873576] LNet: Added LNI 192.168.206.17@tcp50 [8/256/0/180] [14381.761939] LNet: Removed LNI 192.168.206.17@tcp [14382.953810] Lustre: 304792:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff93dad8417800: config has no valid NIDs, force dynamic NIDs [14384.157158] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [14384.931189] Lustre: Unmounted lustre-client [14416.937155] Key type lgssc unregistered [14417.323427] LNet: 305665:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14417.329701] LNetError: 305665:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14417.351168] LNet: Removed LNI 192.168.206.17@tcp50 [14417.925608] Key type .llcrypt unregistered [14417.932911] Key type ._llcrypt unregistered [14427.768354] Key type ._llcrypt registered [14427.769975] Key type .llcrypt registered [14428.998756] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 03:10:44 (1786432244) [14446.500501] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14446.614798] alg: No test for adler32 (adler32-zlib) [14447.687704] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [14447.903809] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [14449.609232] Key type lgssc registered [14450.593662] Lustre: Echo OBD driver; http://www.lustre.org/ [14534.377724] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14541.697592] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14564.919550] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14596.924742] Key type lgssc unregistered [14597.259751] LNet: 310412:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14597.270276] LNetError: 310412:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14597.295923] LNet: Removed LNI 192.168.206.17@tcp [14598.126938] Key type .llcrypt unregistered [14598.137131] Key type ._llcrypt unregistered [14610.160941] Key type ._llcrypt registered [14610.165507] Key type .llcrypt registered [14611.826376] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 03:13:47 (1786432427) [14614.312190] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14614.380897] alg: No test for adler32 (adler32-zlib) [14615.534494] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [14615.840630] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [14617.600197] Key type lgssc registered [14618.718428] Lustre: Echo OBD driver; http://www.lustre.org/ [14665.863304] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14672.048167] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14695.731871] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14698.623110] Lustre: Mounted lustre-client - version 2.17.56_52_gb6f4e2d [14755.111196] Lustre: Mounted fs15246-client - version 2.17.56_52_gb6f4e2d [14768.878947] Lustre: Unmounted fs15246-client [14796.771246] Lustre: Unmounted lustre-client [14833.354738] Key type lgssc unregistered [14833.733739] LNet: 315272:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14833.746914] LNetError: 315272:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14833.775477] LNet: Removed LNI 192.168.206.17@tcp [14834.543790] Key type .llcrypt unregistered [14834.548892] Key type ._llcrypt unregistered [14844.977634] Key type ._llcrypt registered [14844.980806] Key type .llcrypt registered [14846.173924] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 03:17:41 (1786432661) [14848.246601] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14848.266238] alg: No test for adler32 (adler32-zlib) [14849.332433] Lustre: Lustre: Build Version: 2.17.56_52_gb6f4e2d [14849.525069] LNet: Added LNI 192.168.206.17@tcp [8/256/0/180] [14851.224267] Key type lgssc registered [14852.495686] Lustre: Echo OBD driver; http://www.lustre.org/ [14976.811226] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14982.223368] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15004.960701] Lustre: DEBUG MARKER: oleg617-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15101.446400] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 14798 sec ========= 03:21:56 (1786432916) [15103.520527] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 03:21:58 (1786432918) === [15108.181507] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 03:22:03 (1786432923) === [15145.797832] Key type lgssc unregistered [15146.051686] LNet: 324536:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15146.061399] LNetError: 324536:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15146.086309] LNet: Removed LNI 192.168.206.17@tcp [15146.772772] Key type .llcrypt unregistered [15146.775856] Key type ._llcrypt unregistered