[ 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 471879795 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003189] x2apic enabled [ 0.004009] Switched APIC routing to physical x2apic. [ 0.005016] kvm-guest: setup PV IPIs [ 0.008443] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009027] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.012003] pid_max: default: 32768 minimum: 301 [ 0.013145] LSM: Security Framework initializing [ 0.014063] Yama: becoming mindful. [ 0.015040] SELinux: Initializing. [ 0.016064] *** VALIDATE selinux *** [ 0.024766] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.029241] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.030152] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031109] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.033032] *** VALIDATE tmpfs *** [ 0.034444] *** VALIDATE proc *** [ 0.035231] *** VALIDATE cgroup *** [ 0.036006] *** VALIDATE cgroup2 *** [ 0.037210] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.039086] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.040010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.041032] Spectre V2 : User space: Vulnerable [ 0.042005] Speculative Store Bypass: Vulnerable [ 0.045342] debug: unmapping init [mem 0xffffffff9e859000-0xffffffff9e860fff] [ 0.048213] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.049708] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.050024] ... version: 2 [ 0.051017] ... bit width: 48 [ 0.052013] ... generic registers: 4 [ 0.053014] ... value mask: 0000ffffffffffff [ 0.054015] ... max period: 00007fffffffffff [ 0.055015] ... fixed-purpose events: 3 [ 0.056011] ... event mask: 000000070000000f [ 0.057355] rcu: Hierarchical SRCU implementation. [ 0.059507] smp: Bringing up secondary CPUs ... [ 0.060641] x86: Booting SMP configuration: [ 0.061032] .... node #0, CPUs: #1 #2 #3 [ 0.065018] smp: Brought up 1 node, 4 CPUs [ 0.067025] smpboot: Max logical packages: 1 [ 0.068014] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.278213] node 0 deferred pages initialised in 208ms [ 0.281255] devtmpfs: initialized [ 0.282166] x86/mm: Memory block size: 128MB [ 0.284127] gcov: version magic: 0x41383552 [ 0.286057] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.287079] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.288796] pinctrl core: initialized pinctrl subsystem [ 0.289208] [ 0.289689] ************************************************************* [ 0.290016] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.291012] ** ** [ 0.292027] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.293020] ** ** [ 0.294013] ** This means that this kernel is built to expose internal ** [ 0.295013] ** IOMMU data structures, which may compromise security on ** [ 0.296009] ** your system. ** [ 0.297009] ** ** [ 0.298012] ** If you see this message and you are not debugging the ** [ 0.299016] ** kernel, report this immediately to your vendor! ** [ 0.300014] ** ** [ 0.301008] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.302009] ************************************************************* [ 0.303659] NET: Registered protocol family 16 [ 0.304465] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.305067] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.306045] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.307406] cpuidle: using governor menu [ 0.308724] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.311540] PCI: Using configuration type 1 for base access [ 0.312111] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.321063] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.322026] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.324058] cryptd: max_cpu_qlen set to 1000 [ 0.326290] ACPI: Added _OSI(Module Device) [ 0.327013] ACPI: Added _OSI(Processor Device) [ 0.328029] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.329013] ACPI: Added _OSI(Processor Aggregator Device) [ 0.332265] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.338548] ACPI: Interpreter enabled [ 0.340092] ACPI: PM: (supports S0 S3 S4 S5) [ 0.341017] ACPI: Using IOAPIC for interrupt routing [ 0.343161] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.347469] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.358819] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.362062] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.364024] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.368112] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.374608] acpiphp: Slot [2] registered [ 0.376189] acpiphp: Slot [5] registered [ 0.378180] acpiphp: Slot [6] registered [ 0.379397] acpiphp: Slot [3] registered [ 0.381161] acpiphp: Slot [4] registered [ 0.382119] acpiphp: Slot [7] registered [ 0.384141] acpiphp: Slot [8] registered [ 0.385153] acpiphp: Slot [9] registered [ 0.387185] acpiphp: Slot [10] registered [ 0.388135] acpiphp: Slot [11] registered [ 0.390180] acpiphp: Slot [12] registered [ 0.392159] acpiphp: Slot [13] registered [ 0.394240] acpiphp: Slot [14] registered [ 0.395172] acpiphp: Slot [15] registered [ 0.397134] acpiphp: Slot [16] registered [ 0.399142] acpiphp: Slot [17] registered [ 0.401183] acpiphp: Slot [18] registered [ 0.402175] acpiphp: Slot [19] registered [ 0.404229] acpiphp: Slot [20] registered [ 0.406147] acpiphp: Slot [21] registered [ 0.408154] acpiphp: Slot [22] registered [ 0.410152] acpiphp: Slot [23] registered [ 0.412132] acpiphp: Slot [24] registered [ 0.413122] acpiphp: Slot [25] registered [ 0.415134] acpiphp: Slot [26] registered [ 0.416081] acpiphp: Slot [27] registered [ 0.418122] acpiphp: Slot [28] registered [ 0.419121] acpiphp: Slot [29] registered [ 0.421181] acpiphp: Slot [30] registered [ 0.422131] acpiphp: Slot [31] registered [ 0.424116] PCI host bridge to bus 0000:00 [ 0.425041] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.428038] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.430034] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.433037] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.435035] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.438048] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.440237] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.442990] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.446106] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.453447] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.456477] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.458021] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.460015] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.461016] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.463556] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.466978] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.471076] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.475211] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.481021] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.491683] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.496026] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.502156] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.506020] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.515018] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.528019] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.537193] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.544024] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.549019] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.564035] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.575668] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.578605] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.581440] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.583419] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.586374] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.592163] iommu: Default domain type: Passthrough [ 0.593438] SCSI subsystem initialized [ 0.595164] ACPI: bus type USB registered [ 0.596107] usbcore: registered new interface driver usbfs [ 0.598161] usbcore: registered new interface driver hub [ 0.599144] usbcore: registered new device driver usb [ 0.601301] pps_core: LinuxPPS API ver. 1 registered [ 0.603020] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.607102] PTP clock support registered [ 0.609189] EDAC MC: Ver: 3.0.0 [ 0.611232] PCI: Using ACPI for IRQ routing [ 0.614036] NetLabel: Initializing [ 0.615017] NetLabel: domain hash size = 128 [ 0.617019] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.619176] NetLabel: unlabeled traffic allowed by default [ 0.621211] vgaarb: loaded [ 0.623436] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.625020] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.634264] clocksource: Switched to clocksource kvm-clock [ 0.741480] VFS: Disk quotas dquot_6.6.0 [ 0.743381] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.746481] *** VALIDATE ramfs *** [ 0.748100] *** VALIDATE hugetlbfs *** [ 0.750216] pnp: PnP ACPI init [ 0.752631] pnp: PnP ACPI: found 6 devices [ 0.769280] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.772290] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.774708] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.777163] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.778865] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.781497] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.784646] NET: Registered protocol family 2 [ 0.786767] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.790419] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.794556] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.799644] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.803348] TCP: Hash tables configured (established 65536 bind 65536) [ 0.806342] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.808964] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.811868] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.814814] NET: Registered protocol family 1 [ 0.817721] RPC: Registered named UNIX socket transport module. [ 0.823074] RPC: Registered udp transport module. [ 0.825108] RPC: Registered tcp transport module. [ 0.826911] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.829605] NET: Registered protocol family 44 [ 0.862381] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.865049] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.866872] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.869512] PCI: CLS 0 bytes, default 64 [ 0.877275] Unpacking initramfs... [ 2.239464] debug: unmapping init [mem 0xffff93713cc64000-0xffff93713ffcffff] [ 2.243386] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.245743] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.248741] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.748081] Initialise system trusted keyrings [ 2.749752] Key type blacklist registered [ 2.751575] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.761586] zbud: loaded [ 2.764859] *** VALIDATE nfs *** [ 2.766140] *** VALIDATE nfs4 *** [ 2.767847] pstore: using deflate compression [ 2.771831] Platform Keyring initialized [ 2.887465] NET: Registered protocol family 38 [ 2.889096] Key type asymmetric registered [ 2.890446] Asymmetric key parser 'x509' registered [ 2.892130] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.894681] io scheduler mq-deadline registered [ 2.896025] io scheduler kyber registered [ 2.897311] io scheduler bfq registered [ 2.898888] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.901469] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.903861] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.906269] ACPI: Power Button [PWRF] [ 2.911641] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.918856] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.929898] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.957645] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.985787] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.991097] Non-volatile memory driver v1.3 [ 2.992733] Linux agpgart interface v0.103 [ 3.021560] virtio_blk virtio1: [vda] 145904 512-byte logical blocks (74.7 MB/71.2 MiB) [ 3.024482] vda: detected capacity change from 0 to 74702848 [ 3.045425] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.048601] vdb: detected capacity change from 0 to 1073741824 [ 3.055502] libphy: Fixed MDIO Bus: probed [ 3.068572] usbcore: registered new interface driver usbserial_generic [ 3.071328] usbserial: USB Serial support registered for generic [ 3.073513] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.077474] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.079285] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.081267] mousedev: PS/2 mouse device common for all mice [ 3.084261] rtc_cmos 00:05: RTC can wake from S4 [ 3.086426] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.088123] rtc_cmos 00:05: registered as rtc0 [ 3.092276] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.092704] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.095162] intel_pstate: CPU model not supported [ 3.100404] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.102639] hid: raw HID events driver (C) Jiri Kosina [ 3.106190] usbcore: registered new interface driver usbhid [ 3.108229] usbhid: USB HID core driver [ 3.109431] drop_monitor: Initializing network drop monitor service [ 3.111112] Initializing XFRM netlink socket [ 3.112523] NET: Registered protocol family 10 [ 3.114962] Segment Routing with IPv6 [ 3.116161] NET: Registered protocol family 17 [ 3.119121] mpls_gso: MPLS GSO support [ 3.123959] RAS: Correctable Errors collector initialized. [ 3.126666] AVX version of gcm_enc/dec engaged. [ 3.128408] AES CTR mode by8 optimization enabled [ 3.198245] sched_clock: Marking stable (3198160202, 0)->(4041512986, -843352784) [ 3.201664] registered taskstats version 1 [ 3.203431] Loading compiled-in X.509 certificates [ 3.205386] zswap: loaded using pool lzo/zbud [ 3.230981] Key type big_key registered [ 3.244269] Key type encrypted registered [ 3.246213] ima: No TPM chip found, activating TPM-bypass! [ 3.248414] ima: Allocated hash algorithm: sha1 [ 3.250336] ima: No architecture policies found [ 3.252257] evm: Initialising EVM extended attributes: [ 3.254466] evm: security.selinux [ 3.255685] evm: security.ima [ 3.256914] evm: security.capability [ 3.258341] evm: HMAC attrs: 0x1 [ 3.260838] rtc_cmos 00:05: setting system clock to 2026-08-19 05:30:44 UTC (1787117444) [ 3.267732] debug: unmapping init [mem 0xffffffff9f803000-0xffffffff9f9fffff] [ 3.271224] debug: unmapping init [mem 0xffffffff9e582000-0xffffffff9e858fff] [ 3.279279] Write protecting the kernel read-only data: 28672k [ 3.283453] debug: unmapping init [mem 0xffffffff9cc03000-0xffffffff9cdfffff] [ 3.286259] debug: unmapping init [mem 0xffffffff9d514000-0xffffffff9d5fffff] [ 3.315819] 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.324258] systemd[1]: Detected virtualization kvm. [ 3.326483] systemd[1]: Detected architecture x86-64. [ 3.328678] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.359706] systemd[1]: No hostname configured. [ 3.361467] systemd[1]: Set hostname to . [ 3.363795] random: systemd: uninitialized urandom read (16 bytes read) [ 3.366366] systemd[1]: Initializing machine ID from random generator. [ 3.434398] random: ln: uninitialized urandom read (6 bytes read) [ 3.529486] random: systemd: uninitialized urandom read (16 bytes read) [ 3.532325] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.537603] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 3.543981] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Timers. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Swap. [ OK ] Reached target Paths. Starting Apply Kernel Variables... Starting Setup Virtual Console... [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Local Encrypted Volumes. Starting Journal Service... [ OK ] Reached target Slices. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.238612] device-mapper: uevent: version 1.0.3 [ 4.241117] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 5.082605] virtio_net virtio0 ens2: renamed from eth0 [ 5.168096] scsi host0: ata_piix [ 5.193935] scsi host1: ata_piix [ 5.195734] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.198475] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 5.532722] dracut-initqueue[510]: RTNETLINK answers: File exists [ 9.763718] random: crng init done [ 9.765182] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.598429] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Swap. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local File Systems. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.682781] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.945891] SELinux: Disabled at runtime. [ 11.999890] 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) [ 12.009145] systemd[1]: Detected virtualization kvm. [ 12.010821] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.441140] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.444644] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.449647] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.455419] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.458890] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.466180] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.471334] systemd[1]: Created slice system-sshd\x2dkeygen.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on Process Core Dump Socket. Mounting POSIX Message Queue File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on udev Control Socket. Mounting Huge Pages File System... Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Switch Root. [ 12.549237] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS Mounting Kernel Debug File System... [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Reached target Paths. Starting Apply Kernel Variables... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Remount Root and Kernel File Systems... [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice system-getty.slice. [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 12.999721] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 13.316125] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.353885] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.426207] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.434441] EDAC sbridge: Ver: 1.1.2 [ 14.436613] Key type dns_resolver registered [ 14.734609] NFS: Registering the id_resolver key type [ 14.736865] Key type id_resolver registered [ 14.738379] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started daily update of the root trust anchor for DNSSEC. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Reached target sshd-keygen.target. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg140-client login: [ 74.578265] libcfs: loading out-of-tree module taints kernel. [ 74.766977] Key type ._llcrypt registered [ 74.768960] Key type .llcrypt registered [ 75.952863] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 75.974206] alg: No test for adler32 (adler32-zlib) [ 77.827397] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 78.632915] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 78.860800] hrtimer: interrupt took 9859598 ns [ 80.488173] Key type lgssc registered [ 82.562298] Lustre: Echo OBD driver; http://www.lustre.org/ [ 260.925854] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 266.336307] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 280.832488] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing check_logdir /tmp/testlogs/ [ 286.689583] Lustre: lustre-OST0000-osc-ffff9371a11bb000: disconnect after 23s idle [ 288.055331] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing yml_node [ 293.679289] Lustre: DEBUG MARKER: Client: 2.17.57.1 [ 297.317109] Lustre: DEBUG MARKER: MDS: 2.17.57.1 [ 300.471234] Lustre: DEBUG MARKER: OSS: 2.17.57.1 [ 302.873755] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Wed Aug 19 01:35:42 EDT 2026 [ 324.400885] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 326.381970] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 329.561720] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 339.905582] Lustre: Unmounted lustre-client [ 461.273213] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 467.106866] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 494.549795] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 531.829758] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 01:39:31 (1787117971) [ 534.647951] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 536.187729] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 01:39:36 (1787117976) [ 571.966334] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 576.736455] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 596.329255] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 596.784436] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 601.177023] Lustre: Unmounted lustre-client [ 629.591868] Key type lgssc unregistered [ 629.810677] LNet: 15064:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 629.836844] LNetError: 15064:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 629.856340] LNet: Removed LNI 192.168.201.40@tcp [ 630.806306] Key type .llcrypt unregistered [ 630.816069] Key type ._llcrypt unregistered [ 648.074931] Key type ._llcrypt registered [ 648.077547] Key type .llcrypt registered [ 649.765813] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 01:41:29 (1787118089) [ 651.294855] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 651.396430] alg: No test for adler32 (adler32-zlib) [ 652.809402] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 653.456870] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 655.184304] Key type lgssc registered [ 656.861060] Lustre: Echo OBD driver; http://www.lustre.org/ [ 738.579064] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 826.887230] Lustre: Unmounted lustre-client [ 867.755665] Key type lgssc unregistered [ 868.090624] LNet: 18853:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 868.099145] LNetError: 18853:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 868.114627] LNet: Removed LNI 192.168.201.40@tcp [ 868.740993] Key type .llcrypt unregistered [ 868.743276] Key type ._llcrypt unregistered [ 879.599531] Key type ._llcrypt registered [ 879.602417] Key type .llcrypt registered [ 881.241591] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 01:45:20 (1787118320) [ 883.996261] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 884.135531] alg: No test for adler32 (adler32-zlib) [ 885.268476] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 885.498863] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 887.209090] Key type lgssc registered [ 888.469809] Lustre: Echo OBD driver; http://www.lustre.org/ [ 941.922819] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 948.080584] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 971.467154] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 974.176717] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 986.840682] Lustre: Unmounted lustre-client [ 1017.141557] Key type lgssc unregistered [ 1017.639370] LNet: 22462:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1017.650370] LNetError: 22462:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1017.683794] LNet: Removed LNI 192.168.201.40@tcp [ 1018.674158] Key type .llcrypt unregistered [ 1018.676152] Key type ._llcrypt unregistered [ 1030.636134] Key type ._llcrypt registered [ 1030.639743] Key type .llcrypt registered [ 1032.287385] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 01:47:51 (1787118471) [ 1035.039761] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1035.063382] alg: No test for adler32 (adler32-zlib) [ 1036.685859] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 1037.127969] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 1038.976375] Key type lgssc registered [ 1040.825726] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1095.192071] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1101.535000] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1128.183314] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1130.214326] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 1136.552931] Lustre: Unmounted lustre-client [ 1168.762364] Key type lgssc unregistered [ 1169.350632] LNet: 25656:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1169.367779] LNetError: 25656:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1169.391718] LNet: Removed LNI 192.168.201.40@tcp [ 1170.545398] Key type .llcrypt unregistered [ 1170.551193] Key type ._llcrypt unregistered [ 1191.002918] Key type ._llcrypt registered [ 1191.007250] Key type .llcrypt registered [ 1192.394791] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 01:50:32 (1787118632) [ 1195.888759] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1195.905358] alg: No test for adler32 (adler32-zlib) [ 1197.059952] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 1197.330082] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 1199.040232] Key type lgssc registered [ 1200.662694] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1262.198600] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1268.222427] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1291.528824] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1303.674972] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 1313.775863] Lustre: lustre-MDT0000-mdc-ffff9371a0066800: Connection to lustre-MDT0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1324.015929] Lustre: lustre-MDT0001-mdc-ffff9371a0066800: Connection to lustre-MDT0001 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1330.043409] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1335.136617] Lustre: 26617:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787118760/real 1787118760] req@000000002c6d382c x1873929712966272/t0(0) o400->MGC192.168.201.140@tcp@192.168.201.140@tcp:26/25 lens 224/224 e 0 to 1 dl 1787118776 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1335.148593] LustreError: MGC192.168.201.140@tcp: Connection to MGS (at 192.168.201.140@tcp) was lost; in progress operations using this service will fail [ 1340.445423] Lustre: Unmounted lustre-client [ 1354.044447] Key type lgssc unregistered [ 1354.280553] LNet: 29321:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1354.287297] LNetError: 29321:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1354.300534] LNet: Removed LNI 192.168.201.40@tcp [ 1354.909404] Key type .llcrypt unregistered [ 1354.911236] Key type ._llcrypt unregistered [ 1372.678344] Key type ._llcrypt registered [ 1372.683099] Key type .llcrypt registered [ 1374.015841] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 01:53:33 (1787118813) [ 1376.942502] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1376.974708] alg: No test for adler32 (adler32-zlib) [ 1378.164285] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 1378.542981] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 1380.273081] Key type lgssc registered [ 1382.274676] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1438.433713] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1445.366442] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1468.176240] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1470.887951] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 1481.203723] Lustre: lustre-OST0000-osc-ffff9371a11bb800: Connection to lustre-OST0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1486.552721] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1496.923645] Lustre: Unmounted lustre-client [ 1528.542743] Key type lgssc unregistered [ 1528.935860] LNet: 32943:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1528.946916] LNetError: 32943:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1528.981537] LNet: Removed LNI 192.168.201.40@tcp [ 1529.997908] Key type .llcrypt unregistered [ 1530.003741] Key type ._llcrypt unregistered [ 1547.736221] Key type ._llcrypt registered [ 1547.738377] Key type .llcrypt registered [ 1549.116513] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 01:56:28 (1787118988) [ 1552.277899] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1552.309070] alg: No test for adler32 (adler32-zlib) [ 1553.531094] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 1553.849904] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 1555.552866] Key type lgssc registered [ 1556.657262] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1608.619953] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1614.542345] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1638.078803] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1640.996966] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 1648.149963] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1652.239852] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1664.542280] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-19 1h58m23s [ 1667.119176] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1671.663682] Lustre: lustre-MDT0000-mdc-ffff937190bcf800: Connection to lustre-MDT0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1678.181238] LustreError: 36739:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff937190bcf800: can't stat MDS #0: rc = -19 [ 1679.978099] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1690.089774] LustreError: MGC192.168.201.140@tcp: Connection to MGS (at 192.168.201.140@tcp) was lost; in progress operations using this service will fail [ 1690.110247] Lustre: Evicted from MGS (at 192.168.201.140@tcp) after server handle changed from 0x11bf4c488aebed0 to 0x11bf4c488aec19a [ 1690.124225] Lustre: MGC192.168.201.140@tcp: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [ 1691.186714] LustreError: lustre-MDT0000-mdc-ffff937190bcf800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1691.220666] Lustre: lustre-MDT0000-mdc-ffff937190bcf800: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [ 1697.842201] Lustre: DEBUG MARKER: Wait for df (36739) ... [ 1700.441236] Lustre: DEBUG MARKER: done [ 1704.674338] Lustre: Unmounted lustre-client [ 1734.992105] Key type lgssc unregistered [ 1735.301501] LNet: 37761:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1735.309514] LNetError: 37761:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1735.343893] LNet: Removed LNI 192.168.201.40@tcp [ 1735.989664] Key type .llcrypt unregistered [ 1735.996420] Key type ._llcrypt unregistered [ 1772.757105] Key type ._llcrypt registered [ 1772.758701] Key type .llcrypt registered [ 1774.536850] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 02:00:13 (1787119213) [ 1777.541165] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1777.625142] alg: No test for adler32 (adler32-zlib) [ 1778.715525] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 1778.996186] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 1780.752195] Key type lgssc registered [ 1782.168993] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1842.249365] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1849.032721] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1871.988540] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1874.929572] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 1880.084849] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-19 2h01m59s [ 1882.236081] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1891.523289] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1895.054651] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1915.360213] Lustre: 41923:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787119336/real 1787119336] req@000000000119d754 x1873930323237504/t0(0) o101->lustre-MDT0000-mdc-ffff93719072a000@192.168.201.140@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787119356 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1915.401502] Lustre: lustre-MDT0000-mdc-ffff93719072a000: Connection to lustre-MDT0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1915.461291] Lustre: lustre-MDT0000-mdc-ffff93719072a000: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [ 1937.011260] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1939.998227] Lustre: DEBUG MARKER: done [ 1944.581489] Lustre: Unmounted lustre-client [ 1991.683574] Key type lgssc unregistered [ 1991.990916] LNet: 42814:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1992.004186] LNetError: 42814:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1992.026762] LNet: Removed LNI 192.168.201.40@tcp [ 1993.005257] Key type .llcrypt unregistered [ 1993.013749] Key type ._llcrypt unregistered [ 2031.787482] Key type ._llcrypt registered [ 2031.790431] Key type .llcrypt registered [ 2033.379469] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 02:04:32 (1787119472) [ 2034.989642] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2036.899319] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 02:04:36 (1787119476) [ 2042.124217] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2042.193416] alg: No test for adler32 (adler32-zlib) [ 2043.345613] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 2043.619831] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 2045.304200] Key type lgssc registered [ 2046.515086] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2076.471265] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 02:05:16 (1787119516) [ 2114.461921] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2121.846891] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2142.257562] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2143.988611] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 2147.326366] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2151.221979] Lustre: Unmounted lustre-client [ 2171.133715] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2219.054918] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2226.594694] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2227.372168] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 2230.593982] Lustre: Unmounted lustre-client [ 2295.679552] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2302.250763] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2302.973161] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 2307.940826] Lustre: Unmounted lustre-client [ 2335.816466] Lustre: DEBUG MARKER: files compared the same [ 2360.407801] Key type lgssc unregistered [ 2360.739528] LNet: 50453:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2360.744895] LNetError: 50453:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2360.761884] LNet: Removed LNI 192.168.201.40@tcp [ 2361.377808] Key type .llcrypt unregistered [ 2361.382040] Key type ._llcrypt unregistered [ 2378.223562] Key type ._llcrypt registered [ 2378.229743] Key type .llcrypt registered [ 2379.633425] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 02:10:19 (1787119819) [ 2382.108356] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2382.209864] alg: No test for adler32 (adler32-zlib) [ 2383.333633] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 2383.568199] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 2385.248174] Key type lgssc registered [ 2386.603750] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2447.514788] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2454.522119] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2479.249180] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2482.057747] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 2486.537709] Lustre: Unmounted lustre-client [ 2514.449467] Key type lgssc unregistered [ 2514.723750] LNet: 54054:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2514.736584] LNetError: 54054:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2514.778350] LNet: Removed LNI 192.168.201.40@tcp [ 2515.512974] Key type .llcrypt unregistered [ 2515.514780] Key type ._llcrypt unregistered [ 2531.775178] Key type ._llcrypt registered [ 2531.777073] Key type .llcrypt registered [ 2533.043192] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 02:12:52 (1787119972) [ 2536.082856] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2536.271222] alg: No test for adler32 (adler32-zlib) [ 2537.360316] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 2537.681928] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 2539.360254] Key type lgssc registered [ 2540.474438] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2626.345520] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2665.937291] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2672.216963] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2702.123819] Key type lgssc unregistered [ 2702.374562] LNet: 57547:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2702.388497] LNetError: 57547:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2702.408360] LNet: Removed LNI 192.168.201.40@tcp [ 2703.347771] Key type .llcrypt unregistered [ 2703.349533] Key type ._llcrypt unregistered [ 2718.955996] Key type ._llcrypt registered [ 2718.961943] Key type .llcrypt registered [ 2720.115838] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 02:16:00 (1787120160) [ 2723.662514] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2723.704343] alg: No test for adler32 (adler32-zlib) [ 2724.805442] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 2724.999562] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 2726.736245] Key type lgssc registered [ 2728.003639] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2816.398410] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 2824.224304] Lustre: Unmounted lustre-client [ 2864.943441] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 02:18:24 (1787120304) [ 2996.652060] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3019.366103] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 3026.478796] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3026.491769] LustreError: 64016:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff937190bce000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3026.519638] Lustre: 58533:0:(llite_lib.c:4340:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.201.140@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3036.871960] Lustre: Unmounted lustre-client [ 3098.340723] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 02:22:18 (1787120538) [ 3111.781996] Key type lgssc unregistered [ 3112.128859] LNet: 65234:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3112.133938] LNetError: 65234:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3112.161973] LNet: Removed LNI 192.168.201.40@tcp [ 3113.007481] Key type .llcrypt unregistered [ 3113.013532] Key type ._llcrypt unregistered [ 3127.257287] Key type ._llcrypt registered [ 3127.263547] Key type .llcrypt registered [ 3127.984488] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3128.017893] alg: No test for adler32 (adler32-zlib) [ 3129.336590] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 3129.743406] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 3131.496201] Key type lgssc registered [ 3133.204977] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3193.113692] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3201.349249] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3229.133550] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3231.949051] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 3237.494350] Lustre: Unmounted lustre-client [ 3268.114295] Key type lgssc unregistered [ 3268.504225] LNet: 68254:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3268.517586] LNetError: 68254:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3268.543745] LNet: Removed LNI 192.168.201.40@tcp [ 3269.213933] Key type .llcrypt unregistered [ 3269.216692] Key type ._llcrypt unregistered [ 3282.972489] Key type ._llcrypt registered [ 3282.974010] Key type .llcrypt registered [ 3283.766276] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3283.804077] alg: No test for adler32 (adler32-zlib) [ 3285.213875] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 3285.612067] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 3287.321374] Key type lgssc registered [ 3288.673102] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3398.077942] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3403.786703] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3426.657818] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3428.298238] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 3436.259865] Lustre: Unmounted lustre-client [ 3473.262315] Key type lgssc unregistered [ 3473.672098] LNet: 71689:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3473.685581] LNetError: 71689:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3473.709992] LNet: Removed LNI 192.168.201.40@tcp [ 3474.529219] Key type .llcrypt unregistered [ 3474.532706] Key type ._llcrypt unregistered [ 3491.981713] Key type ._llcrypt registered [ 3491.983297] Key type .llcrypt registered [ 3493.305946] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 02:28:53 (1787120933) [ 3495.582978] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3495.599461] alg: No test for adler32 (adler32-zlib) [ 3496.654455] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 3496.946886] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 3498.632279] Key type lgssc registered [ 3499.987457] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3550.751373] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3555.770712] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3579.642722] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3582.520101] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 3588.510454] Lustre: Unmounted lustre-client [ 3589.126216] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 3592.331639] Lustre: Unmounted lustre-client [ 3620.321122] Key type lgssc unregistered [ 3620.641776] LNet: 75382:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3620.653261] LNetError: 75382:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3620.674544] LNet: Removed LNI 192.168.201.40@tcp [ 3621.365727] Key type .llcrypt unregistered [ 3621.368230] Key type ._llcrypt unregistered [ 3633.731823] Key type ._llcrypt registered [ 3633.735234] Key type .llcrypt registered [ 3634.355862] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3634.366342] alg: No test for adler32 (adler32-zlib) [ 3635.530294] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 3635.885323] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 3637.512996] Key type lgssc registered [ 3639.298243] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3689.708725] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3695.627611] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3717.700898] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3719.626169] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 3724.270683] Lustre: Unmounted lustre-client [ 3755.614625] Key type lgssc unregistered [ 3755.845065] LNet: 78418:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3755.858226] LNetError: 78418:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3755.904023] LNet: Removed LNI 192.168.201.40@tcp [ 3756.791722] Key type .llcrypt unregistered [ 3756.796562] Key type ._llcrypt unregistered [ 3776.761198] Key type ._llcrypt registered [ 3776.765687] Key type .llcrypt registered [ 3777.953581] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 02:33:37 (1787121217) [ 3780.851070] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3780.861957] alg: No test for adler32 (adler32-zlib) [ 3782.021891] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 3782.320802] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 3784.008851] Key type lgssc registered [ 3785.641387] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3846.342689] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3852.765205] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3876.444162] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3878.079420] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 3883.618258] Lustre: lustre: root_squash is set to 0:0 [ 3889.340722] Lustre: lustre: nosquash_nids is cleared [ 3899.434936] Lustre: lustre: root_squash is set to 500:500 [ 3907.601017] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.201.40@tcp 192.168.0.[2,10]@tcp [ 3916.868971] Lustre: lustre: nosquash_nids set to 192.168.201.40/24@tcp [ 3922.302296] Lustre: Unmounted lustre-client [ 3952.406925] Key type lgssc unregistered [ 3952.722457] LNet: 82371:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3952.736437] LNetError: 82371:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3952.763476] LNet: Removed LNI 192.168.201.40@tcp [ 3953.671387] Key type .llcrypt unregistered [ 3953.681404] Key type ._llcrypt unregistered [ 3971.836474] Key type ._llcrypt registered [ 3971.839307] Key type .llcrypt registered [ 3973.133128] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 02:36:52 (1787121412) [ 3975.741284] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3977.736434] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 02:36:57 (1787121417) [ 3980.274984] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3980.299328] alg: No test for adler32 (adler32-zlib) [ 3981.370932] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 3981.660191] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 3983.289092] Key type lgssc registered [ 3984.618426] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4041.858440] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4050.549848] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4076.523809] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4078.459861] Lustre: lustre: root_squash is set to 500:500 [ 4078.496023] Lustre: lustre: nosquash_nids set to 192.168.201.40/24@tcp [ 4083.887448] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 4093.642121] Lustre: Unmounted lustre-client [ 4123.773452] Key type lgssc unregistered [ 4124.014355] LNet: 86341:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4124.023257] LNetError: 86341:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4124.052667] LNet: Removed LNI 192.168.201.40@tcp [ 4125.135481] Key type .llcrypt unregistered [ 4125.151487] Key type ._llcrypt unregistered [ 4142.136674] Key type ._llcrypt registered [ 4142.138756] Key type .llcrypt registered [ 4143.277422] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4145.582318] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 02:39:45 (1787121585) [ 4166.906416] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4166.944872] alg: No test for adler32 (adler32-zlib) [ 4167.988618] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 4168.157437] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 4169.800670] Key type lgssc registered [ 4171.532608] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4266.330772] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4272.452647] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4300.281822] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4375.514750] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4381.662778] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4406.071782] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4420.875360] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 4456.340774] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff937184fff000.ost_server_uuid 50 [ 4458.089813] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff937184fff000.ost_server_uuid in FULL state after 0 sec [ 4458.681040] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 4462.404531] Lustre: Unmounted lustre-client [ 4464.783879] Lustre: Unmounted lustre-client [ 4518.491482] Key type lgssc unregistered [ 4518.760834] LNet: 94006:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4518.778578] LNetError: 94006:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4518.805223] LNet: Removed LNI 192.168.201.40@tcp [ 4519.800751] Key type .llcrypt unregistered [ 4519.805511] Key type ._llcrypt unregistered [ 4555.909651] Key type ._llcrypt registered [ 4555.918434] Key type .llcrypt registered [ 4557.102245] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 02:46:36 (1787121996) [ 4578.079055] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4578.204876] alg: No test for adler32 (adler32-zlib) [ 4579.348835] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 4579.584597] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 4581.240792] Key type lgssc registered [ 4582.337963] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4677.930672] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4684.295837] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4710.478150] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4712.335140] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 4732.833097] Lustre: 95370:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787122158/real 1787122158] req@00000000cd79fee3 x1873933259248768/t0(0) o400->lustre-OST0000-osc-ffff9371841d3800@192.168.201.140@tcp:28/4 lens 224/224 e 0 to 1 dl 1787122174 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4732.862274] Lustre: lustre-OST0000-osc-ffff9371841d3800: Connection to lustre-OST0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4738.720224] Lustre: 95369:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787122163/real 1787122163] req@00000000d9cedc58 x1873933259249280/t0(0) o400->lustre-OST0000-osc-ffff9371841d3800@192.168.201.140@tcp:28/4 lens 224/224 e 0 to 1 dl 1787122179 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4744.160265] Lustre: 95369:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787122169/real 1787122169] req@0000000044389b93 x1873933259249792/t0(0) o400->lustre-OST0000-osc-ffff9371841d3800@192.168.201.140@tcp:28/4 lens 224/224 e 0 to 1 dl 1787122185 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4744.815123] Lustre: lustre-OST0000-osc-ffff9371841d3800: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [ 4753.387910] Lustre: lustre-MDT0000-mdc-ffff9371841d3800: Connection to lustre-MDT0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4769.760735] Lustre: 95370:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787122194/real 1787122194] req@00000000a9cd8f51 x1873933259252608/t0(0) o400->MGC192.168.201.140@tcp@192.168.201.140@tcp:26/25 lens 224/224 e 0 to 1 dl 1787122210 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4769.811269] LustreError: MGC192.168.201.140@tcp: Connection to MGS (at 192.168.201.140@tcp) was lost; in progress operations using this service will fail [ 4780.014589] Lustre: Evicted from MGS (at 192.168.201.140@tcp) after server handle changed from 0x20a13e37e64f4998 to 0x20a13e37e64f4b2e [ 4780.050586] Lustre: MGC192.168.201.140@tcp: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [ 4786.164110] Lustre: lustre-MDT0000-mdc-ffff9371841d3800: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [ 4794.323922] Lustre: Unmounted lustre-client [ 4825.268429] Key type lgssc unregistered [ 4825.539407] LNet: 99678:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4825.548626] LNetError: 99678:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4825.571198] LNet: Removed LNI 192.168.201.40@tcp [ 4826.391601] Key type .llcrypt unregistered [ 4826.393922] Key type ._llcrypt unregistered [ 4845.964954] Key type ._llcrypt registered [ 4845.970144] Key type .llcrypt registered [ 4847.435321] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 02:51:26 (1787122286) [ 4862.649822] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4862.703752] alg: No test for adler32 (adler32-zlib) [ 4863.883838] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 4864.303946] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 4866.056266] Key type lgssc registered [ 4867.908456] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4912.664953] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5029.534185] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5035.829375] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5066.514507] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5069.013291] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 5072.265811] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5074.587742] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 02:55:13 (1787122513) [ 5328.944390] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5339.299391] Lustre: Unmounted lustre-client [ 5477.147870] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5484.075687] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5511.833196] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5568.207138] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 03:03:27 (1787123007) [ 5692.768517] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5701.537960] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5728.286149] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5728.944970] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 5733.537383] Lustre: Unmounted lustre-client [ 5766.410581] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 03:06:46 (1787123206) [ 5867.718430] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5874.434253] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5901.359918] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5902.109888] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 5906.943145] Lustre: Unmounted lustre-client [ 5942.918485] Key type lgssc unregistered [ 5943.140919] LNet: 122726:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5943.149980] LNetError: 122726:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5943.174834] LNet: Removed LNI 192.168.201.40@tcp [ 5943.826130] Key type .llcrypt unregistered [ 5943.828509] Key type ._llcrypt unregistered [ 5963.549754] Key type ._llcrypt registered [ 5963.553248] Key type .llcrypt registered [ 5965.151376] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 03:10:04 (1787123404) [ 5967.568203] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5967.616757] alg: No test for adler32 (adler32-zlib) [ 5968.728922] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 5969.042804] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 5970.768254] Key type lgssc registered [ 5971.990722] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6033.097288] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6039.225975] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6061.092545] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6073.374763] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 6086.702175] Lustre: Unmounted lustre-client [ 6123.303680] Key type lgssc unregistered [ 6123.665525] LNet: 126332:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6123.672442] LNetError: 126332:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6123.691776] LNet: Removed LNI 192.168.201.40@tcp [ 6124.388138] Key type .llcrypt unregistered [ 6124.392565] Key type ._llcrypt unregistered [ 6141.629719] Key type ._llcrypt registered [ 6141.632176] Key type .llcrypt registered [ 6143.516166] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 03:13:02 (1787123582) [ 6147.103051] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6147.163705] alg: No test for adler32 (adler32-zlib) [ 6148.595983] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 6148.933537] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 6150.632848] Key type lgssc registered [ 6151.994380] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6212.298308] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6218.950239] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6242.757319] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6245.693329] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 6251.001399] Lustre: lustre-OST0000-osc-ffff937183190000: Connection to lustre-OST0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6263.768406] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff937183190000.ost_server_uuid 50 [ 6265.145761] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6276.563165] Lustre: Unmounted lustre-client [ 6298.645271] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 03:15:38 (1787123738) [ 6337.834330] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6343.831365] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6368.646951] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6391.175762] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6391.844325] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 6396.932527] Lustre: lustre-OST0000-osc-ffff93718482c800: Connection to lustre-OST0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6432.216415] Lustre: Unmounted lustre-client [ 6485.056977] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 03:18:45 (1787123925) [ 6517.345673] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6523.302081] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6544.106082] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6564.499700] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6565.075711] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 6570.500269] Lustre: lustre-OST0000-osc-ffff937190bcc800: Connection to lustre-OST0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6586.112637] Lustre: Unmounted lustre-client [ 6639.965463] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 03:21:19 (1787124079) [ 6737.471766] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6743.252427] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6765.217652] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6830.677397] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6836.626340] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6857.658843] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6886.133050] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 6930.396879] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6932.979622] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 1 sec [ 6935.254313] Lustre: Unmounted lustre-client [ 6984.522303] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 03:27:04 (1787124424) [ 7018.017639] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7024.147387] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7047.321081] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7082.467321] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7113.873065] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 7160.353707] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7161.879638] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7181.815424] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7192.206173] Lustre: Unmounted lustre-client [ 7250.704862] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 03:31:30 (1787124690) [ 7286.072895] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7291.671875] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7313.066066] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7313.739589] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 7336.584280] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7338.535667] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7353.377073] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff937190729000.ost_server_uuid 50 [ 7355.015915] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff937190729000.ost_server_uuid in IDLE state after 0 sec [ 7358.011809] Lustre: Unmounted lustre-client [ 7358.351129] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7358.357543] Lustre: Skipped 3 previous similar messages [ 7358.471898] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 7359.636644] LustreError: 149750:0:(sec.c:403:import_sec_validate_get()) import 000000006e03b05f (NEW) with no sec [ 7423.338350] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 03:34:23 (1787124863) [ 7457.977221] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7464.201364] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7485.587742] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7515.627520] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7516.122730] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7516.216278] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 7528.031686] Lustre: Unmounted lustre-client [ 7528.035625] Lustre: Skipped 1 previous similar message [ 7570.022171] Key type lgssc unregistered [ 7570.383279] LNet: 153163:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7570.390812] LNetError: 153163:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7570.421910] LNet: Removed LNI 192.168.201.40@tcp [ 7571.464290] Key type .llcrypt unregistered [ 7571.467560] Key type ._llcrypt unregistered [ 7588.365932] Key type ._llcrypt registered [ 7588.369225] Key type .llcrypt registered [ 7589.584782] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 03:37:09 (1787125029) [ 7590.780192] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7590.860183] alg: No test for adler32 (adler32-zlib) [ 7591.985261] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 7592.185298] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 7593.833207] Key type lgssc registered [ 7595.034538] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7654.629969] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7662.239725] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7686.193547] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7706.157883] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7707.667977] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7708.810138] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 7711.612465] LustreError: lustre-MDT0001-mdc-ffff93718482d000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7711.635939] Lustre: lustre-MDT0001-mdc-ffff93718482d000: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [ 7717.850492] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7719.687082] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7744.517334] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7753.576071] Lustre: Unmounted lustre-client [ 7786.585555] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 03:40:26 (1787125226) [ 7902.855689] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7908.552281] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7936.740743] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7937.487991] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 7967.668252] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7969.391394] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7983.752991] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7994.159552] Lustre: Unmounted lustre-client [ 8042.559654] Key type lgssc unregistered [ 8043.046363] LNet: 162766:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8043.063018] LNetError: 162766:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8043.084851] LNet: Removed LNI 192.168.201.40@tcp [ 8043.937717] Key type .llcrypt unregistered [ 8043.940700] Key type ._llcrypt unregistered [ 8080.735270] Key type ._llcrypt registered [ 8080.739231] Key type .llcrypt registered [ 8082.177215] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 03:45:21 (1787125521) [ 8085.596210] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8085.619652] alg: No test for adler32 (adler32-zlib) [ 8086.634338] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 8086.951595] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 8088.688205] Key type lgssc registered [ 8090.039992] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8151.849191] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8159.334171] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8188.839162] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8190.612071] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 8241.335873] Lustre: Unmounted lustre-client [ 8289.706416] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8290.686750] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 8328.198875] Lustre: Unmounted lustre-client [ 8358.982910] Key type lgssc unregistered [ 8359.308676] LNet: 167218:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8359.315070] LNetError: 167218:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8360.365240] LNet: Removed LNI 192.168.201.40@tcp [ 8361.432614] Key type .llcrypt unregistered [ 8361.443066] Key type ._llcrypt unregistered [ 8380.923687] Key type ._llcrypt registered [ 8380.925227] Key type .llcrypt registered [ 8382.220386] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 03:50:22 (1787125822) [ 8385.988500] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8386.058076] alg: No test for adler32 (adler32-zlib) [ 8387.259889] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 8387.564072] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 8389.273164] Key type lgssc registered [ 8391.291820] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8458.628391] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8464.955357] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8493.579625] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8495.794736] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 8522.801498] Lustre: Unmounted lustre-client [ 8557.301751] Key type lgssc unregistered [ 8557.612660] LNet: 170983:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8557.624145] LNetError: 170983:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8557.644933] LNet: Removed LNI 192.168.201.40@tcp [ 8558.486499] Key type .llcrypt unregistered [ 8558.496707] Key type ._llcrypt unregistered [ 8572.749174] Key type ._llcrypt registered [ 8572.750460] Key type .llcrypt registered [ 8573.179850] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8573.198592] alg: No test for adler32 (adler32-zlib) [ 8574.284887] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 8574.524187] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 8576.232203] Key type lgssc registered [ 8578.108109] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8633.155819] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8640.525409] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8667.492295] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8673.895570] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 8682.333197] Lustre: Unmounted lustre-client [ 8714.734983] Key type lgssc unregistered [ 8715.013270] LNet: 174049:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8715.028388] LNetError: 174049:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8716.071154] LNet: Removed LNI 192.168.201.40@tcp [ 8716.439110] Key type .llcrypt unregistered [ 8716.440198] Key type ._llcrypt unregistered [ 8733.714331] Key type ._llcrypt registered [ 8733.716702] Key type .llcrypt registered [ 8735.123312] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 03:56:14 (1787126174) [ 8737.987225] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8738.020757] alg: No test for adler32 (adler32-zlib) [ 8739.312506] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 8739.732718] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 8741.552339] Key type lgssc registered [ 8742.964500] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8804.459916] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8812.317757] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8837.526759] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8844.884554] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 8868.402423] Lustre: Unmounted lustre-client [ 8901.783529] Key type lgssc unregistered [ 8902.068423] LNet: 177810:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8902.072397] LNetError: 177810:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8902.084403] LNet: Removed LNI 192.168.201.40@tcp [ 8902.734266] Key type .llcrypt unregistered [ 8902.736344] Key type ._llcrypt unregistered [ 8917.590914] Key type ._llcrypt registered [ 8917.593391] Key type .llcrypt registered [ 8918.121549] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8918.135381] alg: No test for adler32 (adler32-zlib) [ 8919.401431] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 8919.691930] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 8921.368870] Key type lgssc registered [ 8922.689651] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8985.323974] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8992.124809] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9014.505452] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9025.596474] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 9034.086837] Lustre: Unmounted lustre-client [ 9058.443402] Key type lgssc unregistered [ 9058.753369] LNet: 180889:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9058.771594] LNetError: 180889:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9058.790812] LNet: Removed LNI 192.168.201.40@tcp [ 9059.547923] Key type .llcrypt unregistered [ 9059.554523] Key type ._llcrypt unregistered [ 9078.439269] Key type ._llcrypt registered [ 9078.441036] Key type .llcrypt registered [ 9080.162505] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 04:01:59 (1787126519) [ 9107.121310] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9107.288646] alg: No test for adler32 (adler32-zlib) [ 9108.713139] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 9109.250735] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 9111.056348] Key type lgssc registered [ 9112.780407] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9202.829250] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9209.622848] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9236.476493] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9281.516341] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 04:05:21 (1787126721) [ 9324.221029] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9331.038668] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9353.983589] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9365.173558] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 9372.543165] Lustre: Unmounted lustre-client [ 9404.874667] Key type lgssc unregistered [ 9405.235912] LNet: 187992:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9405.250765] LNetError: 187992:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9405.270345] LNet: Removed LNI 192.168.201.40@tcp [ 9406.222536] Key type .llcrypt unregistered [ 9406.225292] Key type ._llcrypt unregistered [ 9425.914295] Key type ._llcrypt registered [ 9425.916602] Key type .llcrypt registered [ 9427.869326] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9429.966464] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 04:07:49 (1787126869) [ 9451.827965] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9451.892208] alg: No test for adler32 (adler32-zlib) [ 9453.210774] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [ 9453.446474] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [ 9455.096699] Key type lgssc registered [ 9456.391260] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9559.267942] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9567.253267] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9596.033545] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9621.698767] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9623.669479] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [ 9647.372382] Lustre: Unmounted lustre-client [ 9795.944403] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9804.163606] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9832.154169] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9877.491775] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 04:15:17 (1787127317) [ 9879.128481] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9880.873388] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 04:15:20 (1787127320) [ 9992.997987] Key type lgssc unregistered [ 9993.218279] LNet: 199445:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9993.235280] LNetError: 199445:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9993.263100] LNet: Removed LNI 192.168.201.40@tcp [ 9994.106909] Key type .llcrypt unregistered [ 9994.111864] Key type ._llcrypt unregistered [10013.669354] Key type ._llcrypt registered [10013.676680] Key type .llcrypt registered [10015.120768] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 04:17:34 (1787127454) [10060.992770] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10061.081249] alg: No test for adler32 (adler32-zlib) [10062.252649] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [10062.475476] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [10064.120165] Key type lgssc registered [10065.608859] Lustre: Echo OBD driver; http://www.lustre.org/ [10122.792517] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10129.489212] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10172.469192] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10206.026400] Key type lgssc unregistered [10206.382231] LNet: 203189:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10206.392936] LNetError: 203189:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10206.414932] LNet: Removed LNI 192.168.201.40@tcp [10207.213819] Key type .llcrypt unregistered [10207.218465] Key type ._llcrypt unregistered [10224.283617] Key type ._llcrypt registered [10224.286920] Key type .llcrypt registered [10225.518330] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 04:21:05 (1787127665) [10228.744526] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10228.773282] alg: No test for adler32 (adler32-zlib) [10229.956592] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [10230.311738] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [10232.008616] Key type lgssc registered [10233.989768] Lustre: Echo OBD driver; http://www.lustre.org/ [10292.912798] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10300.056129] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10327.625211] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10334.789906] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [10344.942513] Lustre: lustre-MDT0000-mdc-ffff937183192000: Connection to lustre-MDT0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [10355.181521] Lustre: lustre-MDT0001-mdc-ffff937183192000: Connection to lustre-MDT0001 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [10366.433710] Lustre: 204180:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787127791/real 1787127791] req@000000008b30ac9e x1873939184828672/t0(0) o400->MGC192.168.201.140@tcp@192.168.201.140@tcp:26/25 lens 224/224 e 0 to 1 dl 1787127807 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10366.494539] LustreError: MGC192.168.201.140@tcp: Connection to MGS (at 192.168.201.140@tcp) was lost; in progress operations using this service will fail [10391.017639] Lustre: Evicted from MGS (at 192.168.201.140@tcp) after server handle changed from 0xc70ede7fc3748d3f to 0xc70ede7fc374aa1f [10391.029156] Lustre: MGC192.168.201.140@tcp: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [10406.377115] LustreError: lustre-MDT0000-mdc-ffff937183192000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10406.408917] Lustre: lustre-MDT0000-mdc-ffff937183192000: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [10410.278430] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10412.363461] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10419.148447] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10420.795532] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10425.580109] Lustre: Unmounted lustre-client [10457.008606] Key type lgssc unregistered [10457.498675] LNet: 208147:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10457.514718] LNetError: 208147:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10457.542397] LNet: Removed LNI 192.168.201.40@tcp [10458.589922] Key type .llcrypt unregistered [10458.593221] Key type ._llcrypt unregistered [10478.419380] Key type ._llcrypt registered [10478.421281] Key type .llcrypt registered [10479.966655] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 04:25:19 (1787127919) [10483.560792] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10483.580419] alg: No test for adler32 (adler32-zlib) [10484.693712] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [10484.969813] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [10486.632351] Key type lgssc registered [10487.928403] Lustre: Echo OBD driver; http://www.lustre.org/ [10545.997663] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10553.025416] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10616.240946] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10623.832871] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10665.544920] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10691.694310] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10736.403479] Key type lgssc unregistered [10736.674638] LNet: 213449:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10736.696432] LNetError: 213449:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10736.715597] LNet: Removed LNI 192.168.201.40@tcp [10737.469122] Key type .llcrypt unregistered [10737.474577] Key type ._llcrypt unregistered [10788.436740] Key type ._llcrypt registered [10788.438619] Key type .llcrypt registered [10789.919317] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 04:30:29 (1787128229) [10835.925292] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10836.153503] alg: No test for adler32 (adler32-zlib) [10837.655818] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [10838.247861] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [10840.224240] Key type lgssc registered [10842.199300] Lustre: Echo OBD driver; http://www.lustre.org/ [10934.584383] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10941.420902] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10970.243390] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11019.942571] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 04:34:19 (1787128459) [11029.491628] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 04:34:28 (1787128468) [11066.960719] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11072.835260] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11099.199229] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11102.236955] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [11107.850521] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [11110.205723] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [11111.922328] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [11114.594627] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [11117.584178] Lustre: lustre-MDT0000-mdc-ffff937191108000: Connection to lustre-MDT0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [11132.769635] Lustre: 215349:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787128558/real 1787128558] req@00000000e8e92276 x1873939822290176/t0(0) o400->MGC192.168.201.140@tcp@192.168.201.140@tcp:26/25 lens 224/224 e 0 to 1 dl 1787128574 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11132.819758] LustreError: MGC192.168.201.140@tcp: Connection to MGS (at 192.168.201.140@tcp) was lost; in progress operations using this service will fail [11143.155376] Lustre: Evicted from MGS (at 192.168.201.140@tcp) after server handle changed from 0x53deea8bf645d5ef to 0x53deea8bf645d762 [11143.173125] Lustre: MGC192.168.201.140@tcp: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [11151.378546] Lustre: lustre-MDT0000-mdc-ffff937191108000: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [11161.401531] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11162.938489] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11166.392407] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [11173.872323] Lustre: lustre-MDT0000-mdc-ffff937191108000: Connection to lustre-MDT0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [11190.178182] Lustre: 215351:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787128615/real 1787128615] req@00000000ec6e56cc x1873939822299520/t0(0) o400->MGC192.168.201.140@tcp@192.168.201.140@tcp:26/25 lens 224/224 e 0 to 1 dl 1787128631 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11190.222737] LustreError: MGC192.168.201.140@tcp: Connection to MGS (at 192.168.201.140@tcp) was lost; in progress operations using this service will fail [11201.600944] Lustre: Evicted from MGS (at 192.168.201.140@tcp) after server handle changed from 0x53deea8bf645d762 to 0x53deea8bf645db6e [11201.625516] Lustre: MGC192.168.201.140@tcp: Connection restored to 192.168.201.140@tcp (at 192.168.201.140@tcp) [11216.528427] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11218.233618] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11221.490142] Lustre: Unmounted lustre-client [11297.144687] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11303.708195] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11326.376834] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11327.193449] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [11334.476574] Lustre: Unmounted lustre-client [11362.495660] Key type lgssc unregistered [11362.811772] LNet: 225949:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11362.819323] LNetError: 225949:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11362.845065] LNet: Removed LNI 192.168.201.40@tcp [11363.629170] Key type .llcrypt unregistered [11363.644300] Key type ._llcrypt unregistered [11380.533550] Key type ._llcrypt registered [11380.537396] Key type .llcrypt registered [11381.636175] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 04:40:21 (1787128821) [11386.064530] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11386.136905] alg: No test for adler32 (adler32-zlib) [11387.209544] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [11387.445177] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [11389.168214] Key type lgssc registered [11390.723795] Lustre: Echo OBD driver; http://www.lustre.org/ [11440.851030] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11447.432621] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11468.148882] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11470.850858] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [11480.749188] Lustre: Unmounted lustre-client [11555.421598] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11563.501026] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11590.219965] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11591.272354] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [11601.825305] Lustre: Unmounted lustre-client [11681.867358] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11688.325134] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11715.929416] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11721.770225] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [11724.087399] Lustre: Unmounted lustre-client [11753.705353] Key type lgssc unregistered [11753.976166] LNet: 233012:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11753.990759] LNetError: 233012:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11754.020943] LNet: Removed LNI 192.168.201.40@tcp [11754.820838] Key type .llcrypt unregistered [11754.823067] Key type ._llcrypt unregistered [11771.586983] Key type ._llcrypt registered [11771.589526] Key type .llcrypt registered [11772.709839] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 04:46:52 (1787129212) [11776.963142] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11777.061591] alg: No test for adler32 (adler32-zlib) [11778.234617] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [11778.548524] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [11780.320514] Key type lgssc registered [11782.069845] Lustre: Echo OBD driver; http://www.lustre.org/ [11832.654432] Key type lgssc unregistered [11833.009931] LNet: 235341:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11833.015762] LNetError: 235341:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11833.041205] LNet: Removed LNI 192.168.201.40@tcp [11833.784543] Key type .llcrypt unregistered [11833.786280] Key type ._llcrypt unregistered [11869.414841] Key type ._llcrypt registered [11869.477077] Key type .llcrypt registered [11869.844974] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11869.857545] alg: No test for adler32 (adler32-zlib) [11870.947039] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [11871.148333] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [11872.792247] Key type lgssc registered [11874.200407] Lustre: Echo OBD driver; http://www.lustre.org/ [11968.428512] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11974.585194] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12001.210274] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12051.741971] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [12053.645227] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 04:51:33 (1787129493) [12102.104533] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12108.317829] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12135.068199] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12166.363762] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12168.472441] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [12173.812542] Lustre: lustre-OST0001-osc-ffff93719091d000: Connection to lustre-OST0001 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [12183.488306] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12193.870947] Lustre: Unmounted lustre-client [12239.966275] Key type lgssc unregistered [12240.271131] LNet: 242468:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12240.279341] LNetError: 242468:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12240.296736] LNet: Removed LNI 192.168.201.40@tcp [12241.374861] Key type .llcrypt unregistered [12241.378360] Key type ._llcrypt unregistered [12284.827229] Key type ._llcrypt registered [12284.828909] Key type .llcrypt registered [12286.095996] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 04:55:25 (1787129725) [12304.813817] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12304.863448] alg: No test for adler32 (adler32-zlib) [12306.002861] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [12306.383679] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [12308.136544] Key type lgssc registered [12309.590544] Lustre: Echo OBD driver; http://www.lustre.org/ [12373.138493] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12380.390832] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12406.235538] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 04:57:25 (1787129845) [12448.400584] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12454.962659] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12480.610835] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12483.484355] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [12495.364578] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12502.144164] Lustre: Unmounted lustre-client [12619.713809] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12628.807376] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12685.342789] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12686.197247] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [12688.765774] Lustre: Unmounted lustre-client [12718.379369] Key type lgssc unregistered [12718.623769] LNet: 250174:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12718.630414] LNetError: 250174:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12718.641914] LNet: Removed LNI 192.168.201.40@tcp [12719.515912] Key type .llcrypt unregistered [12719.527661] Key type ._llcrypt unregistered [12752.829169] Key type ._llcrypt registered [12752.835434] Key type .llcrypt registered [12753.530971] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12753.547970] alg: No test for adler32 (adler32-zlib) [12754.742285] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [12755.179801] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [12756.904224] Key type lgssc registered [12757.956523] Lustre: Echo OBD driver; http://www.lustre.org/ [12847.681583] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12854.660558] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12881.171444] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12927.247554] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12929.216893] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 05:06:08 (1787130368) [12969.947887] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12975.724287] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12994.992944] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12999.236482] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [13007.402522] Lustre: Unmounted lustre-client [13035.824301] Key type lgssc unregistered [13036.088847] LNet: 256828:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13036.098754] LNetError: 256828:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13036.127350] LNet: Removed LNI 192.168.201.40@tcp [13036.755496] Key type .llcrypt unregistered [13036.758571] Key type ._llcrypt unregistered [13052.536195] Key type ._llcrypt registered [13052.544832] Key type .llcrypt registered [13053.730314] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [13055.519521] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 05:08:15 (1787130495) [13065.244774] Key type .llcrypt unregistered [13065.247583] Key type ._llcrypt unregistered [13074.594826] Key type ._llcrypt registered [13074.610499] Key type .llcrypt registered [13074.872543] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13074.892881] alg: No test for adler32 (adler32-zlib) [13075.996980] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [13076.237116] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [13077.904248] Key type lgssc registered [13079.518741] Lustre: Echo OBD driver; http://www.lustre.org/ [13137.121295] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13154.913800] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [13159.334813] Lustre: Unmounted lustre-client [13197.210974] Key type lgssc unregistered [13197.540805] LNet: 260290:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13197.554693] LNetError: 260290:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13197.573564] LNet: Removed LNI 192.168.201.40@tcp [13198.401442] Key type .llcrypt unregistered [13198.404283] Key type ._llcrypt unregistered [13216.311854] Key type ._llcrypt registered [13216.314298] Key type .llcrypt registered [13217.541868] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 05:10:57 (1787130657) [13220.030865] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13220.051798] alg: No test for adler32 (adler32-zlib) [13221.109986] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [13221.325995] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [13222.976209] Key type lgssc registered [13224.372461] Lustre: Echo OBD driver; http://www.lustre.org/ [13313.414962] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13350.416885] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13356.040055] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13357.543494] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [13360.282128] Lustre: Unmounted lustre-client [13388.777457] Key type lgssc unregistered [13389.040138] LNet: 263835:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13389.048162] LNetError: 263835:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13389.090191] LNet: Removed LNI 192.168.201.40@tcp [13389.817501] Key type .llcrypt unregistered [13389.819771] Key type ._llcrypt unregistered [13406.642428] Key type ._llcrypt registered [13406.644467] Key type .llcrypt registered [13407.968903] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 05:14:07 (1787130847) [13410.565554] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13410.618433] alg: No test for adler32 (adler32-zlib) [13411.794765] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [13411.974878] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [13413.624224] Key type lgssc registered [13414.782259] Lustre: Echo OBD driver; http://www.lustre.org/ [13472.597390] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13478.801120] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13499.407744] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13502.369336] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [13507.559888] Lustre: lustre-MDT0000-mdc-ffff937190bcd000: Connection to lustre-MDT0000 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [13513.024837] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13513.080270] LustreError: 266992:0:(file.c:6156:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13513.643873] LustreError: 267011:0:(file.c:6156:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13513.652983] LustreError: 267011:0:(file.c:6156:ll_inode_revalidate_fini()) Skipped 5 previous similar messages [13513.722456] LustreError: MGC192.168.201.140@tcp: Connection to MGS (at 192.168.201.140@tcp) was lost; in progress operations using this service will fail [13513.836190] Lustre: Unmounted lustre-client [13536.209134] Key type lgssc unregistered [13536.485189] LNet: 267410:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13536.492926] LNetError: 267410:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13536.506474] LNet: Removed LNI 192.168.201.40@tcp [13537.076366] Key type .llcrypt unregistered [13537.078405] Key type ._llcrypt unregistered [13558.101216] Key type ._llcrypt registered [13558.106319] Key type .llcrypt registered [13560.082332] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 05:16:39 (1787130999) [13562.938705] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13562.976393] alg: No test for adler32 (adler32-zlib) [13564.039943] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [13564.354439] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [13566.057581] Key type lgssc registered [13567.109499] Lustre: Echo OBD driver; http://www.lustre.org/ [13618.155161] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13624.979454] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13648.827508] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13651.590216] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [13656.600519] Lustre: lustre-MDT0001-mdc-ffff937198a1d000: Connection to lustre-MDT0001 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [13662.347708] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13665.501179] Lustre: Unmounted lustre-client [13685.871857] Key type lgssc unregistered [13686.114188] LNet: 270990:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13686.117686] LNetError: 270990:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13686.127381] LNet: Removed LNI 192.168.201.40@tcp [13686.874138] Key type .llcrypt unregistered [13686.876241] Key type ._llcrypt unregistered [13703.758410] Key type ._llcrypt registered [13703.761442] Key type .llcrypt registered [13705.388352] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 05:19:04 (1787131144) [13725.651974] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13725.681246] alg: No test for adler32 (adler32-zlib) [13726.875645] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [13727.233779] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [13728.992531] Key type lgssc registered [13730.651235] Lustre: Echo OBD driver; http://www.lustre.org/ [13849.636553] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13851.578075] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [13892.590347] Lustre: lustre-MDT0001-mdc-ffff937184679000: Connection to lustre-MDT0001 (at 192.168.201.140@tcp) was lost; in progress operations using this service will wait for recovery to complete [13903.838875] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13914.182141] Lustre: Unmounted lustre-client [13942.058403] Key type lgssc unregistered [13942.377931] LNet: 276778:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13942.384825] LNetError: 276778:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13942.399839] LNet: Removed LNI 192.168.201.40@tcp [13943.291150] Key type .llcrypt unregistered [13943.293439] Key type ._llcrypt unregistered [13965.235531] Key type ._llcrypt registered [13965.242609] Key type .llcrypt registered [13966.635305] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 05:23:26 (1787131406) [13968.987566] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13971.028900] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 05:23:30 (1787131410) [13972.984613] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13974.983242] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 05:23:34 (1787131414) [13976.851988] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13978.367313] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 05:23:38 (1787131418) [13979.993690] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13982.055820] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 05:23:41 (1787131421) [13983.802075] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13985.640065] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 05:23:45 (1787131425) [13993.518539] Key type .llcrypt unregistered [13993.521570] Key type ._llcrypt unregistered [14001.729588] Key type ._llcrypt registered [14001.732426] Key type .llcrypt registered [14002.383870] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14002.413499] alg: No test for adler32 (adler32-zlib) [14003.504639] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [14003.781677] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [14005.464229] Key type lgssc registered [14006.714700] Lustre: Echo OBD driver; http://www.lustre.org/ [14090.259719] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14099.235698] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14125.363288] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14128.347162] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [14130.683172] Lustre: Unmounted lustre-client [14170.732835] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 05:26:50 (1787131610) [14209.225781] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14216.706492] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14254.074377] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14254.747480] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [14257.471977] Lustre: Unmounted lustre-client [14303.308290] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 05:29:02 (1787131742) [14304.865613] LNet: 1 local NIs in recovery (showing 1): 192.168.201.40@tcp [14963.914360] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14970.537373] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15007.029029] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15124.586803] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 05:42:44 (1787132564) [15137.298369] Key type lgssc unregistered [15137.689137] LNet: 290322:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15137.698732] LNetError: 290322:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15138.740570] LNet: Removed LNI 192.168.201.40@tcp [15139.726655] Key type .llcrypt unregistered [15139.729928] Key type ._llcrypt unregistered [15256.582640] Key type ._llcrypt registered [15256.585145] Key type .llcrypt registered [15257.022782] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15257.035354] alg: No test for adler32 (adler32-zlib) [15258.196510] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [15258.422360] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [15260.104212] Key type lgssc registered [15261.203107] Lustre: Echo OBD driver; http://www.lustre.org/ [15356.584396] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15364.606239] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15391.964397] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15430.461964] Key type lgssc unregistered [15430.779869] LNet: 294020:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15430.790433] LNetError: 294020:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15430.817960] LNet: Removed LNI 192.168.201.40@tcp [15431.912875] Key type .llcrypt unregistered [15431.920359] Key type ._llcrypt unregistered [15472.827635] Key type ._llcrypt registered [15472.829585] Key type .llcrypt registered [15474.884956] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 05:48:33 (1787132913) [15499.543545] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15499.728121] alg: No test for adler32 (adler32-zlib) [15500.947599] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [15501.239181] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [15502.977288] Key type lgssc registered [15504.684933] Lustre: Echo OBD driver; http://www.lustre.org/ [15556.922487] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 05:49:56 (1787132996) [15571.449971] Key type lgssc unregistered [15571.666375] LNet: 297579:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15571.672956] LNetError: 297579:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15571.696291] LNet: Removed LNI 192.168.201.40@tcp [15572.652103] Key type .llcrypt unregistered [15572.655215] Key type ._llcrypt unregistered [15586.715528] Key type ._llcrypt registered [15586.722240] Key type .llcrypt registered [15587.295933] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15587.308375] alg: No test for adler32 (adler32-zlib) [15588.347296] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [15588.591833] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [15590.306878] Key type lgssc registered [15591.953698] Lustre: Echo OBD driver; http://www.lustre.org/ [15652.439945] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15658.363852] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15683.383974] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16010.226465] LNet: Added LNI 192.168.201.40@tcp50 [8/256/0/180] [16012.067886] LNet: Removed LNI 192.168.201.40@tcp [16014.932400] Lustre: 301996:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff937184fff000: config has no valid NIDs, force dynamic NIDs [16016.228157] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [16016.484467] Lustre: Unmounted lustre-client [16019.878733] Key type lgssc unregistered [16020.305712] LNet: 302259:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16020.313073] LNetError: 302259:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16020.352445] LNet: Removed LNI 192.168.201.40@tcp50 [16021.138050] Key type .llcrypt unregistered [16021.146119] Key type ._llcrypt unregistered [16040.233728] Key type ._llcrypt registered [16040.242430] Key type .llcrypt registered [16040.844166] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [16040.862260] alg: No test for adler32 (adler32-zlib) [16041.989380] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [16042.219480] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [16043.896451] Key type lgssc registered [16045.402505] Lustre: Echo OBD driver; http://www.lustre.org/ [16108.652619] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16115.397455] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16123.101393] LNet: Added LNI 192.168.201.40@tcp50 [8/256/0/180] [16124.062212] LNet: Removed LNI 192.168.201.40@tcp [16125.329580] Lustre: 304951:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff937185ff3800: config has no valid NIDs, force dynamic NIDs [16126.610092] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [16127.284331] Lustre: Unmounted lustre-client [16172.449793] Key type lgssc unregistered [16172.864600] LNet: 305824:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16172.870854] LNetError: 305824:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16172.895293] LNet: Removed LNI 192.168.201.40@tcp50 [16173.474519] Key type .llcrypt unregistered [16173.477317] Key type ._llcrypt unregistered [16187.950132] Key type ._llcrypt registered [16187.951713] Key type .llcrypt registered [16189.330611] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 06:00:29 (1787133629) [16218.363540] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16218.381464] alg: No test for adler32 (adler32-zlib) [16219.485733] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [16219.761766] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [16221.672521] Key type lgssc registered [16223.337552] Lustre: Echo OBD driver; http://www.lustre.org/ [16323.738717] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16330.615875] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16361.345868] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16407.156885] Key type lgssc unregistered [16407.414348] LNet: 310594:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16407.425200] LNetError: 310594:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16407.450108] LNet: Removed LNI 192.168.201.40@tcp [16408.028925] Key type .llcrypt unregistered [16408.036313] Key type ._llcrypt unregistered [16421.090203] Key type ._llcrypt registered [16421.092625] Key type .llcrypt registered [16422.588738] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 06:04:22 (1787133862) [16425.246766] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16425.494543] alg: No test for adler32 (adler32-zlib) [16426.741097] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [16427.060938] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [16428.848202] Key type lgssc registered [16430.246964] Lustre: Echo OBD driver; http://www.lustre.org/ [16485.753175] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16493.841345] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16517.374312] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16528.952979] Lustre: Mounted lustre-client - version 2.17.57_1_g9da61ce [16595.427282] Lustre: Mounted fs15246-client - version 2.17.57_1_g9da61ce [16612.378268] Lustre: Unmounted fs15246-client [16642.741207] Lustre: Unmounted lustre-client [16678.432626] Key type lgssc unregistered [16678.653691] LNet: 315464:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16678.664530] LNetError: 315464:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16679.738518] LNet: Removed LNI 192.168.201.40@tcp [16680.396136] Key type .llcrypt unregistered [16680.397873] Key type ._llcrypt unregistered [16692.008846] Key type ._llcrypt registered [16692.012616] Key type .llcrypt registered [16693.422781] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 06:08:53 (1787134133) [16694.843600] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16694.925528] alg: No test for adler32 (adler32-zlib) [16696.075283] Lustre: Lustre: Build Version: 2.17.57_1_g9da61ce [16696.300969] LNet: Added LNI 192.168.201.40@tcp [8/256/0/180] [16697.936370] Key type lgssc registered [16699.075947] Lustre: Echo OBD driver; http://www.lustre.org/ [16826.659815] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16832.636977] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16859.237100] Lustre: DEBUG MARKER: oleg140-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16981.076078] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16676 sec ========= 06:13:40 (1787134420) [16983.137718] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 06:13:42 (1787134422) === [16986.488690] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 06:13:46 (1787134426) === [17024.917405] Key type lgssc unregistered [17025.285916] LNet: 324738:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17025.319359] LNetError: 324738:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17025.353860] LNet: Removed LNI 192.168.201.40@tcp [17026.176693] Key type .llcrypt unregistered [17026.178345] Key type ._llcrypt unregistered