[ 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 428085063 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.003333] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.006003] kvm-guest: setup PV IPIs [ 0.009000] ..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.009021] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010013] pid_max: default: 32768 minimum: 301 [ 0.011129] LSM: Security Framework initializing [ 0.012059] Yama: becoming mindful. [ 0.013036] SELinux: Initializing. [ 0.014065] *** VALIDATE selinux *** [ 0.022508] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.027363] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028155] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029124] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031109] *** VALIDATE tmpfs *** [ 0.032473] *** VALIDATE proc *** [ 0.033232] *** VALIDATE cgroup *** [ 0.034011] *** VALIDATE cgroup2 *** [ 0.036229] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037152] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039029] Spectre V2 : User space: Vulnerable [ 0.040009] Speculative Store Bypass: Vulnerable [ 0.043220] debug: unmapping init [mem 0xffffffff9f459000-0xffffffff9f460fff] [ 0.045164] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046692] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047023] ... version: 2 [ 0.048012] ... bit width: 48 [ 0.049012] ... generic registers: 4 [ 0.050012] ... value mask: 0000ffffffffffff [ 0.051012] ... max period: 00007fffffffffff [ 0.052013] ... fixed-purpose events: 3 [ 0.053014] ... event mask: 000000070000000f [ 0.054295] rcu: Hierarchical SRCU implementation. [ 0.056398] smp: Bringing up secondary CPUs ... [ 0.057583] x86: Booting SMP configuration: [ 0.058023] .... node #0, CPUs: #1 #2 #3 [ 0.062017] smp: Brought up 1 node, 4 CPUs [ 0.064016] smpboot: Max logical packages: 1 [ 0.065011] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.221021] node 0 deferred pages initialised in 154ms [ 0.224143] devtmpfs: initialized [ 0.225239] x86/mm: Memory block size: 128MB [ 0.227777] gcov: version magic: 0x41383552 [ 0.231337] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.232089] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.235435] pinctrl core: initialized pinctrl subsystem [ 0.237223] [ 0.237628] ************************************************************* [ 0.240019] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.243024] ** ** [ 0.246020] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.249022] ** ** [ 0.252021] ** This means that this kernel is built to expose internal ** [ 0.254016] ** IOMMU data structures, which may compromise security on ** [ 0.257023] ** your system. ** [ 0.259021] ** ** [ 0.262033] ** If you see this message and you are not debugging the ** [ 0.265020] ** kernel, report this immediately to your vendor! ** [ 0.268022] ** ** [ 0.271020] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.273026] ************************************************************* [ 0.276449] NET: Registered protocol family 16 [ 0.279419] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.282055] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.285060] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.289033] cpuidle: using governor menu [ 0.291373] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.294505] PCI: Using configuration type 1 for base access [ 0.296123] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.308098] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.310021] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.314091] cryptd: max_cpu_qlen set to 1000 [ 0.316253] ACPI: Added _OSI(Module Device) [ 0.318017] ACPI: Added _OSI(Processor Device) [ 0.320013] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.322029] ACPI: Added _OSI(Processor Aggregator Device) [ 0.326643] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.333622] ACPI: Interpreter enabled [ 0.335071] ACPI: PM: (supports S0 S3 S4 S5) [ 0.337027] ACPI: Using IOAPIC for interrupt routing [ 0.339104] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.342399] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.353506] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.355036] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.358016] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.360073] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.365475] acpiphp: Slot [2] registered [ 0.366094] acpiphp: Slot [5] registered [ 0.368129] acpiphp: Slot [6] registered [ 0.369104] acpiphp: Slot [3] registered [ 0.370083] acpiphp: Slot [4] registered [ 0.372078] acpiphp: Slot [7] registered [ 0.373097] acpiphp: Slot [8] registered [ 0.374073] acpiphp: Slot [9] registered [ 0.375075] acpiphp: Slot [10] registered [ 0.376088] acpiphp: Slot [11] registered [ 0.378126] acpiphp: Slot [12] registered [ 0.379074] acpiphp: Slot [13] registered [ 0.380084] acpiphp: Slot [14] registered [ 0.381095] acpiphp: Slot [15] registered [ 0.383079] acpiphp: Slot [16] registered [ 0.384072] acpiphp: Slot [17] registered [ 0.385073] acpiphp: Slot [18] registered [ 0.386071] acpiphp: Slot [19] registered [ 0.387128] acpiphp: Slot [20] registered [ 0.388098] acpiphp: Slot [21] registered [ 0.390076] acpiphp: Slot [22] registered [ 0.391069] acpiphp: Slot [23] registered [ 0.392093] acpiphp: Slot [24] registered [ 0.393106] acpiphp: Slot [25] registered [ 0.395101] acpiphp: Slot [26] registered [ 0.397089] acpiphp: Slot [27] registered [ 0.398097] acpiphp: Slot [28] registered [ 0.400108] acpiphp: Slot [29] registered [ 0.402106] acpiphp: Slot [30] registered [ 0.404114] acpiphp: Slot [31] registered [ 0.406059] PCI host bridge to bus 0000:00 [ 0.407019] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.410022] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.413033] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.415022] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.417021] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.419021] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.421150] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.422909] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.426167] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.433013] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.435947] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.438015] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.441014] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.443018] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.445309] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.447839] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.451045] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.454812] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.459012] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.469665] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.473011] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.479345] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.485014] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.493027] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.514028] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.527502] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.532904] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.539013] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.562014] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.571765] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.574372] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.577393] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.579348] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.581233] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.587077] iommu: Default domain type: Passthrough [ 0.589450] SCSI subsystem initialized [ 0.591154] ACPI: bus type USB registered [ 0.593094] usbcore: registered new interface driver usbfs [ 0.595095] usbcore: registered new interface driver hub [ 0.597084] usbcore: registered new device driver usb [ 0.599146] pps_core: LinuxPPS API ver. 1 registered [ 0.601011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.604058] PTP clock support registered [ 0.607063] EDAC MC: Ver: 3.0.0 [ 0.608366] PCI: Using ACPI for IRQ routing [ 0.611141] NetLabel: Initializing [ 0.612014] NetLabel: domain hash size = 128 [ 0.614012] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.617079] NetLabel: unlabeled traffic allowed by default [ 0.620101] vgaarb: loaded [ 0.622209] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.623011] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.628000] clocksource: Switched to clocksource kvm-clock [ 0.736517] VFS: Disk quotas dquot_6.6.0 [ 0.738033] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.740991] *** VALIDATE ramfs *** [ 0.742229] *** VALIDATE hugetlbfs *** [ 0.743426] pnp: PnP ACPI init [ 0.745913] pnp: PnP ACPI: found 6 devices [ 0.784132] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.788040] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.790422] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.793128] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.796091] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.799035] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.802945] NET: Registered protocol family 2 [ 0.805688] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.810908] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.814912] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.820381] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.824475] TCP: Hash tables configured (established 65536 bind 65536) [ 0.827553] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.830965] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.834099] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.837239] NET: Registered protocol family 1 [ 0.840137] RPC: Registered named UNIX socket transport module. [ 0.842683] RPC: Registered udp transport module. [ 0.844712] RPC: Registered tcp transport module. [ 0.846734] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.849755] NET: Registered protocol family 44 [ 0.851726] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.854110] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.856586] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.859346] PCI: CLS 0 bytes, default 64 [ 0.861322] Unpacking initramfs... [ 2.276281] debug: unmapping init [mem 0xffff956dfcc64000-0xffff956dfffcffff] [ 2.280231] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.282508] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.285519] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.782293] Initialise system trusted keyrings [ 2.785409] Key type blacklist registered [ 2.787414] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.795732] zbud: loaded [ 2.799274] *** VALIDATE nfs *** [ 2.800685] *** VALIDATE nfs4 *** [ 2.802288] pstore: using deflate compression [ 2.805646] Platform Keyring initialized [ 2.908378] NET: Registered protocol family 38 [ 2.910479] Key type asymmetric registered [ 2.911720] Asymmetric key parser 'x509' registered [ 2.913472] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.916278] io scheduler mq-deadline registered [ 2.918325] io scheduler kyber registered [ 2.919803] io scheduler bfq registered [ 2.921666] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.924478] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.927393] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.929401] ACPI: Power Button [PWRF] [ 2.935225] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.941786] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.955982] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.984266] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.013325] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.017971] Non-volatile memory driver v1.3 [ 3.020201] Linux agpgart interface v0.103 [ 3.058184] virtio_blk virtio1: [vda] 145904 512-byte logical blocks (74.7 MB/71.2 MiB) [ 3.061875] vda: detected capacity change from 0 to 74702848 [ 3.076922] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.079386] vdb: detected capacity change from 0 to 1073741824 [ 3.085167] libphy: Fixed MDIO Bus: probed [ 3.091161] usbcore: registered new interface driver usbserial_generic [ 3.094820] usbserial: USB Serial support registered for generic [ 3.098040] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.104709] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.107074] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.109456] mousedev: PS/2 mouse device common for all mice [ 3.112054] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.114599] rtc_cmos 00:05: RTC can wake from S4 [ 3.119102] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.119399] rtc_cmos 00:05: registered as rtc0 [ 3.123321] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.124683] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.130805] intel_pstate: CPU model not supported [ 3.134196] hid: raw HID events driver (C) Jiri Kosina [ 3.136554] usbcore: registered new interface driver usbhid [ 3.138771] usbhid: USB HID core driver [ 3.143522] drop_monitor: Initializing network drop monitor service [ 3.146818] Initializing XFRM netlink socket [ 3.149066] NET: Registered protocol family 10 [ 3.152666] Segment Routing with IPv6 [ 3.154303] NET: Registered protocol family 17 [ 3.156402] mpls_gso: MPLS GSO support [ 3.162263] RAS: Correctable Errors collector initialized. [ 3.164649] AVX version of gcm_enc/dec engaged. [ 3.165923] AES CTR mode by8 optimization enabled [ 3.236077] sched_clock: Marking stable (3236058447, 0)->(4131879534, -895821087) [ 3.239617] registered taskstats version 1 [ 3.242104] Loading compiled-in X.509 certificates [ 3.244825] zswap: loaded using pool lzo/zbud [ 3.271323] Key type big_key registered [ 3.284051] Key type encrypted registered [ 3.285686] ima: No TPM chip found, activating TPM-bypass! [ 3.288032] ima: Allocated hash algorithm: sha1 [ 3.289689] ima: No architecture policies found [ 3.291209] evm: Initialising EVM extended attributes: [ 3.292956] evm: security.selinux [ 3.294012] evm: security.ima [ 3.294946] evm: security.capability [ 3.296408] evm: HMAC attrs: 0x1 [ 3.298235] rtc_cmos 00:05: setting system clock to 2026-08-15 16:47:49 UTC (1786812469) [ 3.304708] debug: unmapping init [mem 0xffffffffa0403000-0xffffffffa05fffff] [ 3.308158] debug: unmapping init [mem 0xffffffff9f182000-0xffffffff9f458fff] [ 3.321084] Write protecting the kernel read-only data: 28672k [ 3.323625] debug: unmapping init [mem 0xffffffff9d803000-0xffffffff9d9fffff] [ 3.325612] debug: unmapping init [mem 0xffffffff9e114000-0xffffffff9e1fffff] [ 3.352954] 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.360700] systemd[1]: Detected virtualization kvm. [ 3.362498] systemd[1]: Detected architecture x86-64. [ 3.364121] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.387696] systemd[1]: No hostname configured. [ 3.389387] systemd[1]: Set hostname to . [ 3.391236] random: systemd: uninitialized urandom read (16 bytes read) [ 3.393219] systemd[1]: Initializing machine ID from random generator. [ 3.429806] random: ln: uninitialized urandom read (6 bytes read) [ 3.513616] random: systemd: uninitialized urandom read (16 bytes read) [ 3.515789] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.519756] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 3.523400] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. Starting Apply Kernel Variables... [ OK ] Listening on udev Control Socket. [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... Starting Setup Virtual Console... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.189451] device-mapper: uevent: version 1.0.3 [ 4.192294] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook... [ 4.994442] virtio_net virtio0 ens2: renamed from eth0 [ 5.022866] scsi host0: ata_piix [ 5.033548] scsi host1: ata_piix [ 5.036506] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.040753] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 6.698985] random: fast init done [ 9.504381] dracut-initqueue[587]: RTNETLINK answers: File exists [ 9.805156] random: crng init done [ 9.806656] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 10.272507] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Swap. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.376625] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.616777] SELinux: Disabled at runtime. [ 11.677760] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.687286] systemd[1]: Detected virtualization kvm. [ 11.689472] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.183301] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.186736] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.192123] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.197485] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.201989] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.210491] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.218299] systemd[1]: Activating swap /dev/disk/by-label/SWAP... Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on initctl Compatibility Named Pipe. Mounting Huge Pages File System... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-getty.slice. [ 12.259959] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting Kernel Debug File System... [ OK ] Created slice User and Session Slice. Mounting POSIX Message Queue 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 ] Reached target rpc_pipefs.target. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Reached target Slices. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Initrd File Systems. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Mounted /mnt. [ OK ] Started udev Coldplug all Devices. [ 12.683090] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.954863] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.979371] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.065547] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.090568] EDAC sbridge: Ver: 1.1.2 [ 14.035971] Key type dns_resolver registered [ 14.334897] NFS: Registering the id_resolver key type [ 14.337152] Key type id_resolver registered [ 14.338906] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Restore /run/initramfs on shutdown... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ 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 Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Command Scheduler. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg327-client login: [ 42.053203] libcfs: loading out-of-tree module taints kernel. [ 42.109448] Key type ._llcrypt registered [ 42.112933] Key type .llcrypt registered [ 42.497487] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 42.505056] alg: No test for adler32 (adler32-zlib) [ 43.556671] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 43.901722] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 45.535416] Key type lgssc registered [ 46.321426] Lustre: Echo OBD driver; http://www.lustre.org/ [ 215.304529] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 220.851747] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 234.415726] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing check_logdir /tmp/testlogs/ [ 239.912850] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing yml_node [ 241.120219] Lustre: lustre-OST0000-osc-ffff956e5212d800: disconnect after 24s idle [ 245.575113] Lustre: DEBUG MARKER: Client: 2.17.57.2 [ 248.365610] Lustre: DEBUG MARKER: MDS: 2.17.57.2 [ 250.985907] Lustre: DEBUG MARKER: OSS: 2.17.57.2 [ 252.519215] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sat Aug 15 12:51:57 EDT 2026 [ 268.383573] hrtimer: interrupt took 19564148 ns [ 268.952416] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 270.417631] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 272.720599] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 283.063698] Lustre: Unmounted lustre-client [ 404.363783] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 411.525851] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 436.736675] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 476.275477] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 12:55:40 (1786812940) [ 479.148325] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 481.334462] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 12:55:45 (1786812945) [ 512.459196] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 517.900666] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 539.015317] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 540.083710] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 545.206888] Lustre: Unmounted lustre-client [ 573.621891] Key type lgssc unregistered [ 573.836955] LNet: 15036:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 573.840616] LNetError: 15036:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 573.871229] LNet: Removed LNI 192.168.203.27@tcp [ 574.725154] Key type .llcrypt unregistered [ 574.727600] Key type ._llcrypt unregistered [ 590.870522] Key type ._llcrypt registered [ 590.879469] Key type .llcrypt registered [ 592.104397] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 12:57:36 (1786813056) [ 593.669186] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 593.739797] alg: No test for adler32 (adler32-zlib) [ 594.905169] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 595.232538] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 596.999156] Key type lgssc registered [ 598.008352] Lustre: Echo OBD driver; http://www.lustre.org/ [ 673.445265] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 768.206274] Lustre: Unmounted lustre-client [ 809.890873] Key type lgssc unregistered [ 810.402212] LNet: 18838:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 810.440921] LNetError: 18838:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 810.479987] LNet: Removed LNI 192.168.203.27@tcp [ 811.821980] Key type .llcrypt unregistered [ 811.826876] Key type ._llcrypt unregistered [ 824.759819] Key type ._llcrypt registered [ 824.769836] Key type .llcrypt registered [ 826.156875] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 13:01:30 (1786813290) [ 828.793236] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 828.809676] alg: No test for adler32 (adler32-zlib) [ 829.935813] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 830.287133] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 832.088194] Key type lgssc registered [ 833.481919] Lustre: Echo OBD driver; http://www.lustre.org/ [ 883.251578] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 889.300485] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 914.075326] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 915.739420] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 928.888213] Lustre: Unmounted lustre-client [ 965.958321] Key type lgssc unregistered [ 966.390552] LNet: 22450:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 966.401338] LNetError: 22450:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 966.436331] LNet: Removed LNI 192.168.203.27@tcp [ 967.402952] Key type .llcrypt unregistered [ 967.408992] Key type ._llcrypt unregistered [ 978.337634] Key type ._llcrypt registered [ 978.339649] Key type .llcrypt registered [ 980.060725] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 13:04:04 (1786813444) [ 982.488415] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 982.592774] alg: No test for adler32 (adler32-zlib) [ 983.771265] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 984.016851] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 985.743360] Key type lgssc registered [ 987.451571] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1039.229727] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1045.318532] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1065.161684] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1066.880841] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 1076.527756] Lustre: Unmounted lustre-client [ 1111.361143] Key type lgssc unregistered [ 1111.900511] LNet: 25646:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1111.911884] LNetError: 25646:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1111.944071] LNet: Removed LNI 192.168.203.27@tcp [ 1112.611683] Key type .llcrypt unregistered [ 1112.632058] Key type ._llcrypt unregistered [ 1129.635038] Key type ._llcrypt registered [ 1129.637374] Key type .llcrypt registered [ 1131.688622] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 13:06:35 (1786813595) [ 1134.685302] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1134.731363] alg: No test for adler32 (adler32-zlib) [ 1135.832477] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 1136.026499] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 1137.687286] Key type lgssc registered [ 1138.877491] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1186.611556] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1192.105509] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1211.141807] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1212.900389] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 1218.035415] Lustre: lustre-MDT0000-mdc-ffff956e50738000: Connection to lustre-MDT0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1223.146934] Lustre: lustre-MDT0001-mdc-ffff956e50738000: Connection to lustre-MDT0001 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1230.616791] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1239.519190] Lustre: 26620:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786813689/real 1786813689] req@00000000fe4acfbe x1873609859536256/t0(0) o400->MGC192.168.203.127@tcp@192.168.203.127@tcp:26/25 lens 224/224 e 0 to 1 dl 1786813705 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1239.548493] LustreError: MGC192.168.203.127@tcp: Connection to MGS (at 192.168.203.127@tcp) was lost; in progress operations using this service will fail [ 1240.917725] Lustre: Unmounted lustre-client [ 1261.582480] Key type lgssc unregistered [ 1261.836115] LNet: 29321:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1261.846652] LNetError: 29321:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1261.859511] LNet: Removed LNI 192.168.203.27@tcp [ 1262.536735] Key type .llcrypt unregistered [ 1262.540659] Key type ._llcrypt unregistered [ 1277.538809] Key type ._llcrypt registered [ 1277.545151] Key type .llcrypt registered [ 1279.261673] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 13:09:03 (1786813743) [ 1281.784178] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1281.911077] alg: No test for adler32 (adler32-zlib) [ 1283.259261] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 1283.634301] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 1285.367204] Key type lgssc registered [ 1286.801330] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1337.676086] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1342.930128] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1365.012110] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1367.494337] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 1372.648090] Lustre: lustre-OST0000-osc-ffff956e42f76000: Connection to lustre-OST0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1380.844677] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1391.293510] Lustre: Unmounted lustre-client [ 1421.720527] Key type lgssc unregistered [ 1422.013754] LNet: 32937:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1422.023257] LNetError: 32937:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1422.039488] LNet: Removed LNI 192.168.203.27@tcp [ 1422.657744] Key type .llcrypt unregistered [ 1422.659313] Key type ._llcrypt unregistered [ 1437.743868] Key type ._llcrypt registered [ 1437.748889] Key type .llcrypt registered [ 1439.247701] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 13:11:43 (1786813903) [ 1441.642037] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1441.729696] alg: No test for adler32 (adler32-zlib) [ 1442.792744] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 1442.972466] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 1444.655191] Key type lgssc registered [ 1445.683279] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1497.312420] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1502.849839] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1524.166828] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1526.176634] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 1530.467980] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1535.030996] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1546.776756] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-1513h13m31s [ 1548.475073] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1551.848332] Lustre: lustre-MDT0000-mdc-ffff956e5829e000: Connection to lustre-MDT0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1558.710104] LustreError: 36729:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff956e5829e000: can't stat MDS #0: rc = -19 [ 1560.420167] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1569.257226] LustreError: MGC192.168.203.127@tcp: Connection to MGS (at 192.168.203.127@tcp) was lost; in progress operations using this service will fail [ 1569.268910] Lustre: Evicted from MGS (at 192.168.203.127@tcp) after server handle changed from 0xcac4e35029491958 to 0xcac4e35029491c1b [ 1569.283685] Lustre: MGC192.168.203.127@tcp: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 1570.357319] LustreError: lustre-MDT0000-mdc-ffff956e5829e000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1570.391835] Lustre: lustre-MDT0000-mdc-ffff956e5829e000: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 1574.074060] Lustre: DEBUG MARKER: Wait for df (36729) ... [ 1575.605787] Lustre: DEBUG MARKER: done [ 1577.481463] Lustre: Unmounted lustre-client [ 1604.625469] Key type lgssc unregistered [ 1604.933046] LNet: 37749:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1604.945527] LNetError: 37749:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1604.963685] LNet: Removed LNI 192.168.203.27@tcp [ 1605.613359] Key type .llcrypt unregistered [ 1605.616381] Key type ._llcrypt unregistered [ 1639.954630] Key type ._llcrypt registered [ 1639.959335] Key type .llcrypt registered [ 1641.562772] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 13:15:05 (1786814105) [ 1644.901324] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1644.966978] alg: No test for adler32 (adler32-zlib) [ 1646.114367] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 1646.309148] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 1647.983172] Key type lgssc registered [ 1649.055259] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1697.812814] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1703.674587] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1722.319844] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1724.900686] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 1729.408797] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-1513h16m34s [ 1730.825888] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1737.695925] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1740.041820] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1760.223185] Lustre: 41899:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786814206/real 1786814206] req@00000000b2d29371 x1873610394310784/t0(0) o101->lustre-MDT0000-mdc-ffff956e494c7000@192.168.203.127@tcp:12/10 lens 576/1152 e 0 to 1 dl 1786814226 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1760.240120] Lustre: lustre-MDT0000-mdc-ffff956e494c7000: Connection to lustre-MDT0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1760.269276] Lustre: lustre-MDT0000-mdc-ffff956e494c7000: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 1782.229218] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1785.053751] Lustre: DEBUG MARKER: done [ 1788.841679] Lustre: Unmounted lustre-client [ 1824.705686] Key type lgssc unregistered [ 1824.924731] LNet: 42782:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1824.933953] LNetError: 42782:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1824.948239] LNet: Removed LNI 192.168.203.27@tcp [ 1825.504388] Key type .llcrypt unregistered [ 1825.506572] Key type ._llcrypt unregistered [ 1851.083535] Key type ._llcrypt registered [ 1851.087581] Key type .llcrypt registered [ 1852.571157] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 13:18:37 (1786814317) [ 1854.368987] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1856.501978] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 13:18:41 (1786814321) [ 1860.622779] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1860.642279] alg: No test for adler32 (adler32-zlib) [ 1861.860237] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 1862.207614] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 1863.991169] Key type lgssc registered [ 1865.209199] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1894.724279] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 13:19:19 (1786814359) [ 1925.901806] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1931.308889] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1951.633199] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1954.267168] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 1957.636261] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1960.826388] Lustre: Unmounted lustre-client [ 1970.506971] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2016.481662] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2022.737280] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2023.303353] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 2027.644453] Lustre: Unmounted lustre-client [ 2091.253627] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2096.658208] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2097.558814] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 2101.071705] Lustre: Unmounted lustre-client [ 2116.295821] Lustre: DEBUG MARKER: files compared the same [ 2139.434946] Key type lgssc unregistered [ 2139.764968] LNet: 50416:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2139.774344] LNetError: 50416:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2139.791732] LNet: Removed LNI 192.168.203.27@tcp [ 2140.668974] Key type .llcrypt unregistered [ 2140.676559] Key type ._llcrypt unregistered [ 2155.476770] Key type ._llcrypt registered [ 2155.479034] Key type .llcrypt registered [ 2156.809261] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 13:23:41 (1786814621) [ 2159.065776] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2159.089744] alg: No test for adler32 (adler32-zlib) [ 2160.191482] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 2160.460895] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 2162.224241] Key type lgssc registered [ 2163.960400] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2221.260288] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2228.147036] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2247.378102] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2248.851371] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 2256.660169] Lustre: Unmounted lustre-client [ 2284.455495] Key type lgssc unregistered [ 2284.840852] LNet: 54002:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2284.849324] LNetError: 54002:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2284.881463] LNet: Removed LNI 192.168.203.27@tcp [ 2285.744277] Key type .llcrypt unregistered [ 2285.746858] Key type ._llcrypt unregistered [ 2302.195413] Key type ._llcrypt registered [ 2302.199066] Key type .llcrypt registered [ 2303.784889] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 13:26:08 (1786814768) [ 2306.917030] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2306.932227] alg: No test for adler32 (adler32-zlib) [ 2307.988544] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 2308.206459] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 2309.871507] Key type lgssc registered [ 2311.390703] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2397.968052] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2435.875207] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2441.837078] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2468.617909] Key type lgssc unregistered [ 2468.863415] LNet: 57493:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2468.871592] LNetError: 57493:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2468.891620] LNet: Removed LNI 192.168.203.27@tcp [ 2469.413818] Key type .llcrypt unregistered [ 2469.415412] Key type ._llcrypt unregistered [ 2483.272684] Key type ._llcrypt registered [ 2483.274231] Key type .llcrypt registered [ 2484.426931] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 13:29:09 (1786814949) [ 2488.461211] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2488.572576] alg: No test for adler32 (adler32-zlib) [ 2489.743562] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 2490.064172] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 2491.775319] Key type lgssc registered [ 2493.143563] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2562.798850] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 2570.009921] Lustre: Unmounted lustre-client [ 2612.997798] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 13:31:17 (1786815077) [ 2740.643367] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2758.404934] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 2766.675335] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2766.685835] LustreError: 63971:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff956e494c4000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2766.712477] Lustre: 58478:0:(llite_lib.c:4340:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.203.127@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2777.093975] Lustre: Unmounted lustre-client [ 2828.104235] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 13:34:52 (1786815292) [ 2838.878921] Key type lgssc unregistered [ 2839.078801] LNet: 65185:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2839.087262] LNetError: 65185:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2839.106390] LNet: Removed LNI 192.168.203.27@tcp [ 2839.800088] Key type .llcrypt unregistered [ 2839.802312] Key type ._llcrypt unregistered [ 2852.120624] Key type ._llcrypt registered [ 2852.124510] Key type .llcrypt registered [ 2852.541715] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2852.564783] alg: No test for adler32 (adler32-zlib) [ 2853.563898] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 2853.785586] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 2855.431197] Key type lgssc registered [ 2856.375702] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2902.621668] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2908.902900] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2929.290880] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2930.985198] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 2934.994913] Lustre: Unmounted lustre-client [ 2963.852840] Key type lgssc unregistered [ 2964.148383] LNet: 68209:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2964.154192] LNetError: 68209:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2964.183668] LNet: Removed LNI 192.168.203.27@tcp [ 2964.735331] Key type .llcrypt unregistered [ 2964.739394] Key type ._llcrypt unregistered [ 2974.630603] Key type ._llcrypt registered [ 2974.633030] Key type .llcrypt registered [ 2975.157914] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2975.195072] alg: No test for adler32 (adler32-zlib) [ 2976.227434] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 2976.467051] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 2978.224083] Key type lgssc registered [ 2979.592296] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3080.436222] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3085.882159] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3104.906250] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3106.489988] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 3108.803509] Lustre: Unmounted lustre-client [ 3132.629859] Key type lgssc unregistered [ 3132.848081] LNet: 71645:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3132.858966] LNetError: 71645:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3132.881286] LNet: Removed LNI 192.168.203.27@tcp [ 3133.457977] Key type .llcrypt unregistered [ 3133.460098] Key type ._llcrypt unregistered [ 3146.232129] Key type ._llcrypt registered [ 3146.236958] Key type .llcrypt registered [ 3147.331678] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 13:40:12 (1786815612) [ 3149.435109] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3149.472137] alg: No test for adler32 (adler32-zlib) [ 3150.539756] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 3150.816323] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 3152.527199] Key type lgssc registered [ 3153.840607] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3201.582855] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3206.421634] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3224.837115] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3226.521107] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 3230.951185] Lustre: Unmounted lustre-client [ 3231.338134] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 3233.820912] Lustre: Unmounted lustre-client [ 3255.639797] Key type lgssc unregistered [ 3255.862851] LNet: 75330:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3255.874621] LNetError: 75330:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3255.891980] LNet: Removed LNI 192.168.203.27@tcp [ 3256.451159] Key type .llcrypt unregistered [ 3256.453109] Key type ._llcrypt unregistered [ 3267.433532] Key type ._llcrypt registered [ 3267.459497] Key type .llcrypt registered [ 3267.785414] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3267.797217] alg: No test for adler32 (adler32-zlib) [ 3268.804305] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 3269.031656] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 3270.703187] Key type lgssc registered [ 3271.761460] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3316.850390] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3321.686266] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3341.749483] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3343.411423] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 3347.697259] Lustre: Unmounted lustre-client [ 3374.113983] Key type lgssc unregistered [ 3374.356531] LNet: 78362:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3374.363727] LNetError: 78362:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3374.390804] LNet: Removed LNI 192.168.203.27@tcp [ 3375.020676] Key type .llcrypt unregistered [ 3375.024220] Key type ._llcrypt unregistered [ 3391.071552] Key type ._llcrypt registered [ 3391.074748] Key type .llcrypt registered [ 3392.358358] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 13:44:17 (1786815857) [ 3395.765108] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3395.889140] alg: No test for adler32 (adler32-zlib) [ 3397.246163] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 3397.572218] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 3399.457736] Key type lgssc registered [ 3401.430715] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3458.161332] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3464.120444] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3484.735060] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3487.602815] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 3502.099160] Lustre: lustre: root_squash is set to 0:0 [ 3502.119035] Lustre: lustre: nosquash_nids is cleared [ 3509.294253] Lustre: lustre: root_squash is set to 500:500 [ 3516.118919] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.203.27@tcp 192.168.0.[2,10]@tcp [ 3531.320844] Lustre: lustre: nosquash_nids set to 192.168.203.27/24@tcp [ 3533.946298] Lustre: Unmounted lustre-client [ 3566.263058] Key type lgssc unregistered [ 3566.489239] LNet: 82338:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3566.496433] LNetError: 82338:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3566.514450] LNet: Removed LNI 192.168.203.27@tcp [ 3567.236551] Key type .llcrypt unregistered [ 3567.239030] Key type ._llcrypt unregistered [ 3585.883590] Key type ._llcrypt registered [ 3585.891113] Key type .llcrypt registered [ 3588.166845] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 13:47:31 (1786816051) [ 3591.275363] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3593.313261] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 13:47:37 (1786816057) [ 3597.203084] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3597.330196] alg: No test for adler32 (adler32-zlib) [ 3598.782797] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 3599.205266] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 3600.935422] Key type lgssc registered [ 3602.356303] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3653.692448] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3659.940640] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3680.566702] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3681.077503] Lustre: lustre: root_squash is set to 500:500 [ 3681.101229] Lustre: lustre: nosquash_nids set to 192.168.203.27/24@tcp [ 3682.224324] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 3690.967493] Lustre: Unmounted lustre-client [ 3732.582798] Key type lgssc unregistered [ 3732.870071] LNet: 86302:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3732.879955] LNetError: 86302:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3732.893498] LNet: Removed LNI 192.168.203.27@tcp [ 3733.629923] Key type .llcrypt unregistered [ 3733.633611] Key type ._llcrypt unregistered [ 3748.334642] Key type ._llcrypt registered [ 3748.337128] Key type .llcrypt registered [ 3749.763385] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3751.383486] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 13:50:16 (1786816216) [ 3771.086434] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3771.244180] alg: No test for adler32 (adler32-zlib) [ 3772.295518] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 3772.518119] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 3774.175392] Key type lgssc registered [ 3775.528219] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3859.996979] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3865.695624] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3888.364487] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3965.731581] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3972.828509] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3995.857791] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4007.877185] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 4042.858066] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff956e5255e800.ost_server_uuid 50 [ 4044.536805] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff956e5255e800.ost_server_uuid in IDLE state after 0 sec [ 4045.228021] LustreError: 87629:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 4045.298753] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 4049.752827] Lustre: Unmounted lustre-client [ 4051.463548] Lustre: Unmounted lustre-client [ 4100.649546] Key type lgssc unregistered [ 4100.846545] LNet: 93982:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4100.862460] LNetError: 93982:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4100.879375] LNet: Removed LNI 192.168.203.27@tcp [ 4101.628171] Key type .llcrypt unregistered [ 4101.630465] Key type ._llcrypt unregistered [ 4131.903783] Key type ._llcrypt registered [ 4131.906342] Key type .llcrypt registered [ 4133.042728] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 13:56:37 (1786816597) [ 4150.846114] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4150.909103] alg: No test for adler32 (adler32-zlib) [ 4151.981667] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 4152.226118] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 4153.887279] Key type lgssc registered [ 4155.370490] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4241.919807] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4247.764474] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4272.622287] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4275.160635] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 4296.671193] Lustre: 95361:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786816746/real 1786816746] req@0000000020c89e3a x1873613022041344/t0(0) o400->lustre-OST0000-osc-ffff956e51314800@192.168.203.127@tcp:28/4 lens 224/224 e 0 to 1 dl 1786816762 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4296.708594] Lustre: lustre-OST0000-osc-ffff956e51314800: Connection to lustre-OST0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4300.831187] Lustre: 95360:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786816751/real 1786816751] req@0000000083751007 x1873613022041856/t0(0) o400->lustre-OST0000-osc-ffff956e51314800@192.168.203.127@tcp:28/4 lens 224/224 e 0 to 1 dl 1786816767 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4305.138522] Lustre: lustre-OST0000-osc-ffff956e51314800: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 4306.207825] Lustre: 95361:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786816756/real 1786816756] req@00000000a0966a7f x1873613022042368/t0(0) o400->lustre-OST0000-osc-ffff956e51314800@192.168.203.127@tcp:28/4 lens 224/224 e 0 to 1 dl 1786816772 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4306.926160] Lustre: lustre-MDT0000-mdc-ffff956e51314800: Connection to lustre-MDT0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4311.007186] Lustre: 95361:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786816761/real 1786816761] req@00000000e03ca6bf x1873613022042880/t0(0) o400->lustre-OST0000-osc-ffff956e51314800@192.168.203.127@tcp:28/4 lens 224/224 e 0 to 1 dl 1786816777 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4323.295494] Lustre: 95362:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786816773/real 1786816773] req@000000001acb181d x1873613022044672/t0(0) o400->MGC192.168.203.127@tcp@192.168.203.127@tcp:26/25 lens 224/224 e 0 to 1 dl 1786816789 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4323.316447] LustreError: MGC192.168.203.127@tcp: Connection to MGS (at 192.168.203.127@tcp) was lost; in progress operations using this service will fail [ 4329.220756] Lustre: lustre-MDT0000-mdc-ffff956e51314800: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 4333.734621] Lustre: Evicted from MGS (at 192.168.203.127@tcp) after server handle changed from 0xc9d25043dcd04647 to 0xc9d25043dcd04a76 [ 4333.760775] Lustre: MGC192.168.203.127@tcp: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 4335.184582] Lustre: Unmounted lustre-client [ 4361.737578] Key type lgssc unregistered [ 4361.948895] LNet: 99668:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4361.957125] LNetError: 99668:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4361.969283] LNet: Removed LNI 192.168.203.27@tcp [ 4362.505089] Key type .llcrypt unregistered [ 4362.507147] Key type ._llcrypt unregistered [ 4375.889756] Key type ._llcrypt registered [ 4375.891721] Key type .llcrypt registered [ 4377.273672] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 14:00:41 (1786816841) [ 4392.081732] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4392.133758] alg: No test for adler32 (adler32-zlib) [ 4393.370975] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 4393.554092] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 4395.215191] Key type lgssc registered [ 4396.714476] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4432.897613] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4542.457353] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4548.807172] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4573.970401] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4576.938226] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 4579.209480] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4582.169525] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 14:04:06 (1786817046) [ 4837.043876] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4847.415082] Lustre: Unmounted lustre-client [ 4983.714798] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4989.842553] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5012.843155] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5051.739237] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 14:11:56 (1786817516) [ 5139.414199] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5144.638632] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5165.333426] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5166.075076] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 5171.148340] Lustre: Unmounted lustre-client [ 5209.301511] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 14:14:33 (1786817673) [ 5300.486655] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5306.027275] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5329.414958] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5329.966849] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 5333.301945] Lustre: Unmounted lustre-client [ 5365.041762] Key type lgssc unregistered [ 5365.430597] LNet: 122716:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5365.442921] LNetError: 122716:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5365.490303] LNet: Removed LNI 192.168.203.27@tcp [ 5366.577933] Key type .llcrypt unregistered [ 5366.580683] Key type ._llcrypt unregistered [ 5386.018750] Key type ._llcrypt registered [ 5386.023169] Key type .llcrypt registered [ 5387.436933] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 14:17:32 (1786817852) [ 5390.098609] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5390.208085] alg: No test for adler32 (adler32-zlib) [ 5391.318566] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 5391.573838] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 5393.395516] Key type lgssc registered [ 5395.083631] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5447.275780] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5454.063918] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5474.781743] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5476.616275] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 5492.345986] Lustre: Unmounted lustre-client [ 5520.326325] Key type lgssc unregistered [ 5520.621380] LNet: 126316:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5520.629085] LNetError: 126316:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5521.703061] LNet: Removed LNI 192.168.203.27@tcp [ 5522.467796] Key type .llcrypt unregistered [ 5522.475845] Key type ._llcrypt unregistered [ 5543.456959] Key type ._llcrypt registered [ 5543.461536] Key type .llcrypt registered [ 5546.102766] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 14:20:09 (1786818009) [ 5549.318836] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5549.349591] alg: No test for adler32 (adler32-zlib) [ 5550.539779] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 5551.006642] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 5552.735315] Key type lgssc registered [ 5554.404750] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5608.580555] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5613.793313] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5632.851935] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5634.623639] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 5639.660058] Lustre: lustre-OST0000-osc-ffff956e5829e000: Connection to lustre-OST0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5654.810103] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff956e5829e000.ost_server_uuid 50 [ 5656.709867] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5668.187721] Lustre: Unmounted lustre-client [ 5689.263766] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 14:22:34 (1786818154) [ 5721.256516] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5727.742556] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5747.046498] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5768.208518] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5768.742639] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 5773.803733] Lustre: lustre-OST0000-osc-ffff956e45f5a800: Connection to lustre-OST0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5796.410183] Lustre: Unmounted lustre-client [ 5843.854596] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 14:25:08 (1786818308) [ 5873.274025] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5878.424523] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5899.254882] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5920.972223] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5921.517189] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 5926.898449] Lustre: lustre-OST0000-osc-ffff956e488b0800: Connection to lustre-OST0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5940.971254] Lustre: Unmounted lustre-client [ 5992.788138] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 14:27:37 (1786818457) [ 6077.978867] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6082.667240] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6103.032743] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6165.209313] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6170.652555] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6197.750165] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6238.919985] LustreError: 127276:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 6238.980630] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 6279.901656] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6286.445972] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 5 sec [ 6287.859212] Lustre: Unmounted lustre-client [ 6319.975388] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 14:33:05 (1786818785) [ 6351.624543] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6357.394869] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6378.002704] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6411.493714] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6440.731228] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 6484.924726] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6486.252773] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6497.413417] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6507.760376] Lustre: Unmounted lustre-client [ 6566.841205] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 14:37:11 (1786819031) [ 6599.369758] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6607.911772] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6630.581815] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6630.957398] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 6652.372269] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6653.832895] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6668.812995] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff956e47931000.ost_server_uuid 50 [ 6670.402589] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff956e47931000.ost_server_uuid in IDLE state after 0 sec [ 6673.595977] Lustre: Unmounted lustre-client [ 6674.081924] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6674.088974] Lustre: Skipped 3 previous similar messages [ 6674.211714] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 6675.729095] LustreError: 149774:0:(sec.c:403:import_sec_validate_get()) import 00000000b69b77ff (NEW) with no sec [ 6740.826974] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 14:40:05 (1786819205) [ 6773.698680] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6779.191734] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6798.456528] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6818.749089] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6819.137971] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6819.260201] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 6831.715617] Lustre: Unmounted lustre-client [ 6831.723641] Lustre: Skipped 1 previous similar message [ 6864.780345] Key type lgssc unregistered [ 6864.984250] LNet: 153191:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6864.989972] LNetError: 153191:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6865.009822] LNet: Removed LNI 192.168.203.27@tcp [ 6865.571336] Key type .llcrypt unregistered [ 6865.573802] Key type ._llcrypt unregistered [ 6878.528368] Key type ._llcrypt registered [ 6878.532295] Key type .llcrypt registered [ 6879.809850] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 14:42:24 (1786819344) [ 6880.958408] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6880.979626] alg: No test for adler32 (adler32-zlib) [ 6882.130434] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 6882.382878] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 6884.127729] Key type lgssc registered [ 6885.265589] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6936.173275] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6941.996532] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6962.790312] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6986.654133] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6987.258140] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6988.436045] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 6993.237983] LustreError: lustre-MDT0001-mdc-ffff956e4737c800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6993.258485] Lustre: lustre-MDT0001-mdc-ffff956e4737c800: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 6998.821891] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7000.195510] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7019.022096] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7027.697176] Lustre: Unmounted lustre-client [ 7060.123868] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 14:45:25 (1786819525) [ 7151.977651] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7158.267899] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7179.260928] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7179.928625] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 7203.848821] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7205.112864] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7209.459678] Lustre: lustre-OST0001-osc-ffff956e5073d000: Connection to lustre-OST0001 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7216.713393] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7227.098783] Lustre: Unmounted lustre-client [ 7262.195671] Key type lgssc unregistered [ 7262.635485] LNet: 162788:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7262.645546] LNetError: 162788:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7262.659231] LNet: Removed LNI 192.168.203.27@tcp [ 7263.475496] Key type .llcrypt unregistered [ 7263.481321] Key type ._llcrypt unregistered [ 7293.719319] Key type ._llcrypt registered [ 7293.723103] Key type .llcrypt registered [ 7294.697890] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 14:49:19 (1786819759) [ 7296.814367] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7296.833371] alg: No test for adler32 (adler32-zlib) [ 7297.930236] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 7298.131962] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 7299.783292] Key type lgssc registered [ 7301.087784] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7348.963784] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7354.631859] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7375.892396] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7378.829422] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 7425.398530] Lustre: Unmounted lustre-client [ 7466.371892] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7467.013526] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 7503.876968] Lustre: Unmounted lustre-client [ 7530.399665] Key type lgssc unregistered [ 7530.644757] LNet: 167244:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7530.650442] LNetError: 167244:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7530.665771] LNet: Removed LNI 192.168.203.27@tcp [ 7531.217068] Key type .llcrypt unregistered [ 7531.221247] Key type ._llcrypt unregistered [ 7546.931844] Key type ._llcrypt registered [ 7546.939745] Key type .llcrypt registered [ 7548.163384] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 14:53:32 (1786820012) [ 7550.765913] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7550.805746] alg: No test for adler32 (adler32-zlib) [ 7551.898521] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 7552.108664] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 7553.871332] Key type lgssc registered [ 7555.083908] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7607.639270] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7614.707284] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7639.901670] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7641.655668] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 7660.605656] Lustre: Unmounted lustre-client [ 7688.198462] Key type lgssc unregistered [ 7688.470273] LNet: 171002:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7688.478285] LNetError: 171002:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7688.491649] LNet: Removed LNI 192.168.203.27@tcp [ 7689.029517] Key type .llcrypt unregistered [ 7689.032280] Key type ._llcrypt unregistered [ 7701.463119] Key type ._llcrypt registered [ 7701.464912] Key type .llcrypt registered [ 7701.709811] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7701.718286] alg: No test for adler32 (adler32-zlib) [ 7702.945828] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 7703.489230] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 7705.383668] Key type lgssc registered [ 7706.654421] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7755.302579] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7761.010472] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7780.500494] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7783.166220] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 7789.760872] Lustre: Unmounted lustre-client [ 7818.448283] Key type lgssc unregistered [ 7818.662970] LNet: 174067:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7818.667262] LNetError: 174067:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7818.683070] LNet: Removed LNI 192.168.203.27@tcp [ 7819.307258] Key type .llcrypt unregistered [ 7819.312559] Key type ._llcrypt unregistered [ 7835.843898] Key type ._llcrypt registered [ 7835.845937] Key type .llcrypt registered [ 7836.814471] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 14:58:21 (1786820301) [ 7839.482986] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7839.593463] alg: No test for adler32 (adler32-zlib) [ 7841.022604] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 7841.345138] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 7843.120512] Key type lgssc registered [ 7844.732597] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7898.818556] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7904.778875] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7926.639602] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7929.603669] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 7953.236128] Lustre: Unmounted lustre-client [ 7979.938486] Key type lgssc unregistered [ 7980.212703] LNet: 177826:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7980.218177] LNetError: 177826:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7980.237562] LNet: Removed LNI 192.168.203.27@tcp [ 7980.982993] Key type .llcrypt unregistered [ 7980.986076] Key type ._llcrypt unregistered [ 7993.669974] Key type ._llcrypt registered [ 7993.672986] Key type .llcrypt registered [ 7994.179845] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7994.211505] alg: No test for adler32 (adler32-zlib) [ 7995.320541] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 7995.570773] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 7997.231256] Key type lgssc registered [ 7998.714277] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8065.778184] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8072.010548] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8094.022879] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8096.655058] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 8106.543548] Lustre: Unmounted lustre-client [ 8133.325389] Key type lgssc unregistered [ 8133.548755] LNet: 180904:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8133.568222] LNetError: 180904:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8133.595535] LNet: Removed LNI 192.168.203.27@tcp [ 8134.569260] Key type .llcrypt unregistered [ 8134.574601] Key type ._llcrypt unregistered [ 8152.708088] Key type ._llcrypt registered [ 8152.710271] Key type .llcrypt registered [ 8153.954485] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 15:03:38 (1786820618) [ 8176.140331] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8176.183350] alg: No test for adler32 (adler32-zlib) [ 8177.239865] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 8177.498341] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 8179.167300] Key type lgssc registered [ 8180.419988] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8267.071692] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8273.782475] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8296.833777] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8341.264031] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 15:06:46 (1786820806) [ 8374.456879] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8380.580402] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8402.437154] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8404.447648] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 8412.366811] Lustre: Unmounted lustre-client [ 8448.221179] Key type lgssc unregistered [ 8448.518402] LNet: 188005:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8448.526961] LNetError: 188005:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8448.546962] LNet: Removed LNI 192.168.203.27@tcp [ 8449.221622] Key type .llcrypt unregistered [ 8449.223705] Key type ._llcrypt unregistered [ 8467.417138] Key type ._llcrypt registered [ 8467.419355] Key type .llcrypt registered [ 8469.563938] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8472.172371] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 15:08:56 (1786820936) [ 8494.106474] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8494.136075] alg: No test for adler32 (adler32-zlib) [ 8495.260765] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 8495.588035] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 8497.439220] Key type lgssc registered [ 8498.879053] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8588.692209] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8594.628150] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8617.621223] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8642.578870] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8645.725438] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 8672.644900] Lustre: Unmounted lustre-client [ 8789.316669] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8794.446691] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8814.853439] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8858.935600] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 15:15:24 (1786821324) [ 8860.342806] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8861.941223] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 15:15:26 (1786821326) [ 8945.583929] Key type lgssc unregistered [ 8945.856705] LNet: 199443:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8945.873589] LNetError: 199443:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8945.899228] LNet: Removed LNI 192.168.203.27@tcp [ 8946.684794] Key type .llcrypt unregistered [ 8946.689197] Key type ._llcrypt unregistered [ 8961.266597] Key type ._llcrypt registered [ 8961.272362] Key type .llcrypt registered [ 8962.585562] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 15:17:07 (1786821427) [ 9002.972741] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9003.095672] alg: No test for adler32 (adler32-zlib) [ 9004.158913] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 9004.364917] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 9006.071246] Key type lgssc registered [ 9006.981524] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9055.701952] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9061.455338] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9094.911769] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9130.648811] Key type lgssc unregistered [ 9130.904794] LNet: 203196:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9130.913259] LNetError: 203196:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9130.938229] LNet: Removed LNI 192.168.203.27@tcp [ 9131.655987] Key type .llcrypt unregistered [ 9131.659368] Key type ._llcrypt unregistered [ 9148.781415] Key type ._llcrypt registered [ 9148.784057] Key type .llcrypt registered [ 9150.333961] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 15:20:14 (1786821614) [ 9153.086075] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9153.258138] alg: No test for adler32 (adler32-zlib) [ 9154.465686] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 9154.799711] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 9156.511473] Key type lgssc registered [ 9157.641707] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9208.374816] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9213.422583] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9233.574805] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9236.199893] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 9246.700408] Lustre: lustre-MDT0000-mdc-ffff956e45a6d800: Connection to lustre-MDT0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9256.951543] Lustre: lustre-MDT0001-mdc-ffff956e45a6d800: Connection to lustre-MDT0001 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9268.001733] Lustre: 204187:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786821718/real 1786821718] req@0000000026d5418c x1873618267095168/t0(0) o400->MGC192.168.203.127@tcp@192.168.203.127@tcp:26/25 lens 224/224 e 0 to 1 dl 1786821734 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9268.028631] LustreError: MGC192.168.203.127@tcp: Connection to MGS (at 192.168.203.127@tcp) was lost; in progress operations using this service will fail [ 9278.315162] Lustre: Evicted from MGS (at 192.168.203.127@tcp) after server handle changed from 0xff70735b031c8a90 to 0xff70735b031ca769 [ 9278.341289] Lustre: MGC192.168.203.127@tcp: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 9302.012799] LustreError: lustre-MDT0000-mdc-ffff956e45a6d800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9302.042842] Lustre: lustre-MDT0000-mdc-ffff956e45a6d800: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 9306.101989] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9307.887676] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9313.634786] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9315.707904] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9318.545162] Lustre: Unmounted lustre-client [ 9348.725978] Key type lgssc unregistered [ 9348.960071] LNet: 208139:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9348.966746] LNetError: 208139:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9348.980782] LNet: Removed LNI 192.168.203.27@tcp [ 9349.893311] Key type .llcrypt unregistered [ 9349.895936] Key type ._llcrypt unregistered [ 9366.152970] Key type ._llcrypt registered [ 9366.156092] Key type .llcrypt registered [ 9367.382255] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 15:23:52 (1786821832) [ 9369.821532] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9369.849941] alg: No test for adler32 (adler32-zlib) [ 9371.032809] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 9371.327628] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 9373.072738] Key type lgssc registered [ 9374.261268] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9420.094499] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9425.391640] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9487.842274] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9494.658110] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9530.223588] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9554.331438] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9599.317551] Key type lgssc unregistered [ 9599.510631] LNet: 213434:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9599.518035] LNetError: 213434:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9599.537738] LNet: Removed LNI 192.168.203.27@tcp [ 9600.269935] Key type .llcrypt unregistered [ 9600.271851] Key type ._llcrypt unregistered [ 9638.675855] Key type ._llcrypt registered [ 9638.680868] Key type .llcrypt registered [ 9639.621582] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 15:28:24 (1786822104) [ 9674.306248] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9674.377732] alg: No test for adler32 (adler32-zlib) [ 9675.341860] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [ 9675.528536] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [ 9677.191417] Key type lgssc registered [ 9678.191771] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9755.584824] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9761.655323] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9786.281566] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9829.234852] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 15:31:33 (1786822293) [ 9841.611653] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 15:31:46 (1786822306) [ 9876.766202] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9882.705371] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9903.022559] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9904.629587] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [ 9909.692548] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9911.792662] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9913.624785] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9915.056535] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9919.982031] Lustre: lustre-MDT0000-mdc-ffff956e43c9c000: Connection to lustre-MDT0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9936.352787] Lustre: 215329:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786822386/real 1786822386] req@000000006e2b91fc x1873618813331072/t0(0) o400->MGC192.168.203.127@tcp@192.168.203.127@tcp:26/25 lens 224/224 e 0 to 1 dl 1786822402 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9936.388241] LustreError: MGC192.168.203.127@tcp: Connection to MGS (at 192.168.203.127@tcp) was lost; in progress operations using this service will fail [ 9942.326687] Lustre: lustre-MDT0000-mdc-ffff956e43c9c000: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 9946.408129] Lustre: Evicted from MGS (at 192.168.203.127@tcp) after server handle changed from 0x48b424173364aec8 to 0x48b424173364b2cd [ 9946.415916] Lustre: MGC192.168.203.127@tcp: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 9950.755208] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9952.153227] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9955.653597] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9961.961539] Lustre: lustre-MDT0000-mdc-ffff956e43c9c000: Connection to lustre-MDT0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9977.323714] LustreError: MGC192.168.203.127@tcp: Connection to MGS (at 192.168.203.127@tcp) was lost; in progress operations using this service will fail [ 9977.355854] Lustre: Evicted from MGS (at 192.168.203.127@tcp) after server handle changed from 0x48b424173364b2cd to 0x48b424173364b447 [ 9977.369409] Lustre: MGC192.168.203.127@tcp: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 9980.664078] Lustre: lustre-MDT0000-mdc-ffff956e43c9c000: Connection restored to 192.168.203.127@tcp (at 192.168.203.127@tcp) [ 9987.622939] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9989.091402] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9991.945670] Lustre: Unmounted lustre-client [10068.164259] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10074.845683] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10099.849524] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10111.031333] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [10112.737034] Lustre: Unmounted lustre-client [10136.494065] Key type lgssc unregistered [10136.678494] LNet: 225902:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10136.686708] LNetError: 225902:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10136.700129] LNet: Removed LNI 192.168.203.27@tcp [10137.398447] Key type .llcrypt unregistered [10137.404667] Key type ._llcrypt unregistered [10154.989514] Key type ._llcrypt registered [10154.991915] Key type .llcrypt registered [10156.489369] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 15:37:01 (1786822621) [10161.607573] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10161.618757] alg: No test for adler32 (adler32-zlib) [10162.738741] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [10163.164047] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [10164.903390] Key type lgssc registered [10165.965290] Lustre: Echo OBD driver; http://www.lustre.org/ [10223.426206] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10230.610620] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10253.206351] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10256.183614] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [10262.242894] Lustre: Unmounted lustre-client [10325.068943] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10330.131255] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10350.486742] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10351.080996] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [10359.550173] Lustre: Unmounted lustre-client [10422.889471] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10428.265652] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10447.602970] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10448.245317] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [10449.928528] Lustre: Unmounted lustre-client [10476.119663] Key type lgssc unregistered [10476.302599] LNet: 232952:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10476.307443] LNetError: 232952:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10476.326213] LNet: Removed LNI 192.168.203.27@tcp [10476.934096] Key type .llcrypt unregistered [10476.936645] Key type ._llcrypt unregistered [10490.097556] Key type ._llcrypt registered [10490.100235] Key type .llcrypt registered [10491.089635] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 15:42:36 (1786822956) [10493.592506] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10493.674727] alg: No test for adler32 (adler32-zlib) [10494.726468] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [10495.013073] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [10496.687206] Key type lgssc registered [10497.676940] Lustre: Echo OBD driver; http://www.lustre.org/ [10536.743785] Key type lgssc unregistered [10537.041758] LNet: 235270:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10537.047897] LNetError: 235270:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10537.066107] LNet: Removed LNI 192.168.203.27@tcp [10537.673643] Key type .llcrypt unregistered [10537.676475] Key type ._llcrypt unregistered [10563.175577] Key type ._llcrypt registered [10563.186493] Key type .llcrypt registered [10563.608419] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10563.620168] alg: No test for adler32 (adler32-zlib) [10564.683644] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [10564.891134] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [10566.583215] Key type lgssc registered [10567.531386] Lustre: Echo OBD driver; http://www.lustre.org/ [10640.523888] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10646.115722] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10674.996812] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10739.017644] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10742.142314] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 15:46:45 (1786823205) [10777.359926] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10783.705486] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10806.098886] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10826.370186] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10827.964599] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [10833.395485] Lustre: lustre-OST0001-osc-ffff956e4866b000: Connection to lustre-OST0001 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [10840.993060] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10851.354193] Lustre: Unmounted lustre-client [10886.808991] Key type lgssc unregistered [10886.990788] LNet: 242387:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10886.995707] LNetError: 242387:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10887.012961] LNet: Removed LNI 192.168.203.27@tcp [10887.607073] Key type .llcrypt unregistered [10887.609063] Key type ._llcrypt unregistered [10923.117033] Key type ._llcrypt registered [10923.122390] Key type .llcrypt registered [10924.598840] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 15:49:49 (1786823389) [10938.352231] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10938.639089] alg: No test for adler32 (adler32-zlib) [10939.743767] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [10940.149925] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [10941.832611] Key type lgssc registered [10943.346455] Lustre: Echo OBD driver; http://www.lustre.org/ [10992.847300] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10999.021355] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11031.690923] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 15:51:36 (1786823496) [11066.592668] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11071.739838] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11091.787804] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11093.568272] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [11106.833947] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11109.669973] Lustre: Unmounted lustre-client [11211.366074] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11216.556995] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11269.832163] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11270.321581] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [11272.449823] Lustre: Unmounted lustre-client [11299.324591] Key type lgssc unregistered [11299.524348] LNet: 250100:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11299.530751] LNetError: 250100:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11299.555864] LNet: Removed LNI 192.168.203.27@tcp [11300.104821] Key type .llcrypt unregistered [11300.107553] Key type ._llcrypt unregistered [11329.523119] Key type ._llcrypt registered [11329.535457] Key type .llcrypt registered [11330.116789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11330.135256] alg: No test for adler32 (adler32-zlib) [11331.549341] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [11331.954692] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [11333.591212] Key type lgssc registered [11334.847347] Lustre: Echo OBD driver; http://www.lustre.org/ [11413.484963] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11418.932332] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11440.317503] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11488.911236] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11490.997218] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 15:59:15 (1786823955) [11522.066514] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11527.608569] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11547.251197] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11551.776872] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [11554.160514] Lustre: Unmounted lustre-client [11584.165425] Key type lgssc unregistered [11584.529051] LNet: 256734:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11584.542315] LNetError: 256734:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11584.577218] LNet: Removed LNI 192.168.203.27@tcp [11585.681856] Key type .llcrypt unregistered [11585.691081] Key type ._llcrypt unregistered [11600.366261] Key type ._llcrypt registered [11600.368530] Key type .llcrypt registered [11601.461299] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11602.848106] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 16:01:07 (1786824067) [11610.299276] Key type .llcrypt unregistered [11610.306311] Key type ._llcrypt unregistered [11617.544858] Key type ._llcrypt registered [11617.576686] Key type .llcrypt registered [11617.933352] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11617.965391] alg: No test for adler32 (adler32-zlib) [11619.041182] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [11619.315954] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [11621.031199] Key type lgssc registered [11622.052711] Lustre: Echo OBD driver; http://www.lustre.org/ [11664.771461] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11682.593461] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [11684.814740] Lustre: Unmounted lustre-client [11710.340436] Key type lgssc unregistered [11710.592400] LNet: 260202:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11710.606055] LNetError: 260202:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11710.626852] LNet: Removed LNI 192.168.203.27@tcp [11711.279587] Key type .llcrypt unregistered [11711.285232] Key type ._llcrypt unregistered [11723.768618] Key type ._llcrypt registered [11723.770377] Key type .llcrypt registered [11725.093403] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 16:03:09 (1786824189) [11727.373187] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11727.390414] alg: No test for adler32 (adler32-zlib) [11728.448266] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [11728.636246] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [11730.295176] Key type lgssc registered [11731.319992] Lustre: Echo OBD driver; http://www.lustre.org/ [11810.861561] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11841.948613] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11847.947325] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11850.522446] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [11853.393287] Lustre: Unmounted lustre-client [11871.908797] Key type lgssc unregistered [11872.185376] LNet: 263747:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11872.197453] LNetError: 263747:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11872.222315] LNet: Removed LNI 192.168.203.27@tcp [11873.016468] Key type .llcrypt unregistered [11873.019062] Key type ._llcrypt unregistered [11892.648984] Key type ._llcrypt registered [11892.654701] Key type .llcrypt registered [11894.496934] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 16:05:58 (1786824358) [11897.044982] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11897.213751] alg: No test for adler32 (adler32-zlib) [11898.307834] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [11898.482375] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [11900.191408] Key type lgssc registered [11901.228850] Lustre: Echo OBD driver; http://www.lustre.org/ [11947.466425] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11954.934684] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11974.418163] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11977.111109] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [11982.311996] Lustre: lustre-MDT0000-mdc-ffff956e485ca800: Connection to lustre-MDT0000 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [11987.032895] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11987.079655] LustreError: 266903:0:(file.c:6156:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [11987.549961] LustreError: MGC192.168.203.127@tcp: Connection to MGS (at 192.168.203.127@tcp) was lost; in progress operations using this service will fail [11987.625793] Lustre: Unmounted lustre-client [12009.475893] Key type lgssc unregistered [12009.718036] LNet: 267321:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12009.724709] LNetError: 267321:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12009.743411] LNet: Removed LNI 192.168.203.27@tcp [12010.498313] Key type .llcrypt unregistered [12010.503793] Key type ._llcrypt unregistered [12025.918983] Key type ._llcrypt registered [12025.921118] Key type .llcrypt registered [12027.247974] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 16:08:11 (1786824491) [12029.430298] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12029.462026] alg: No test for adler32 (adler32-zlib) [12030.543222] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [12030.928880] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [12032.719722] Key type lgssc registered [12034.026483] Lustre: Echo OBD driver; http://www.lustre.org/ [12085.339878] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12091.376556] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12110.484714] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12112.692292] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [12117.992389] Lustre: lustre-MDT0001-mdc-ffff956e460b4800: Connection to lustre-MDT0001 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [12122.728718] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12125.111859] Lustre: Unmounted lustre-client [12143.428066] Key type lgssc unregistered [12143.645931] LNet: 270901:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12143.652538] LNetError: 270901:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12143.681618] LNet: Removed LNI 192.168.203.27@tcp [12144.192064] Key type .llcrypt unregistered [12144.195290] Key type ._llcrypt unregistered [12158.947579] Key type ._llcrypt registered [12158.952231] Key type .llcrypt registered [12160.613080] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 16:10:24 (1786824624) [12177.418608] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12177.460224] alg: No test for adler32 (adler32-zlib) [12178.564848] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [12178.821645] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [12180.671247] Key type lgssc registered [12182.030991] Lustre: Echo OBD driver; http://www.lustre.org/ [12298.537863] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12301.503811] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [12336.103902] Lustre: lustre-MDT0001-mdc-ffff956e428eb000: Connection to lustre-MDT0001 (at 192.168.203.127@tcp) was lost; in progress operations using this service will wait for recovery to complete [12345.745596] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12356.086180] Lustre: Unmounted lustre-client [12382.339796] Key type lgssc unregistered [12382.559805] LNet: 276690:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12382.567085] LNetError: 276690:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12382.588130] LNet: Removed LNI 192.168.203.27@tcp [12383.184106] Key type .llcrypt unregistered [12383.186133] Key type ._llcrypt unregistered [12397.254261] Key type ._llcrypt registered [12397.256607] Key type .llcrypt registered [12398.353493] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 16:14:23 (1786824863) [12399.702327] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12401.853835] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 16:14:26 (1786824866) [12403.858295] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12405.650249] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 16:14:30 (1786824870) [12407.543478] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12409.423881] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 16:14:34 (1786824874) [12411.246375] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12414.121867] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 16:14:38 (1786824878) [12416.128944] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12417.887728] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 16:14:42 (1786824882) [12426.560110] Key type .llcrypt unregistered [12426.563596] Key type ._llcrypt unregistered [12432.117245] Key type ._llcrypt registered [12432.122156] Key type .llcrypt registered [12432.612124] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12432.623196] alg: No test for adler32 (adler32-zlib) [12433.666607] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [12433.963249] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [12435.688429] Key type lgssc registered [12436.732723] Lustre: Echo OBD driver; http://www.lustre.org/ [12506.745655] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12512.483825] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12534.845889] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12536.612902] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [12538.935613] Lustre: Unmounted lustre-client [12574.932595] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 16:17:19 (1786825039) [12612.844408] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12618.762631] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12651.680951] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12657.763430] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [12661.098707] Lustre: Unmounted lustre-client [12709.412402] LNet: 1 local NIs in recovery (showing 1): 192.168.203.27@tcp [12716.676549] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 16:19:41 (1786825181) [13359.672292] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13365.278969] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13396.523966] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13494.847833] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 16:32:39 (1786825959) [13508.829722] Key type lgssc unregistered [13509.117081] LNet: 290231:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13509.125542] LNetError: 290231:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13509.142625] LNet: Removed LNI 192.168.203.27@tcp [13509.743703] Key type .llcrypt unregistered [13509.750229] Key type ._llcrypt unregistered [13648.699750] Key type ._llcrypt registered [13648.702328] Key type .llcrypt registered [13649.146994] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13649.163232] alg: No test for adler32 (adler32-zlib) [13650.270530] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [13650.510486] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [13652.223181] Key type lgssc registered [13653.361156] Lustre: Echo OBD driver; http://www.lustre.org/ [13733.136380] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13737.237041] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13757.288783] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13787.416845] Key type lgssc unregistered [13787.670962] LNet: 293926:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13787.675720] LNetError: 293926:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13787.686214] LNet: Removed LNI 192.168.203.27@tcp [13788.274705] Key type .llcrypt unregistered [13788.278597] Key type ._llcrypt unregistered [13823.663419] Key type ._llcrypt registered [13823.667836] Key type .llcrypt registered [13826.124282] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 16:38:09 (1786826289) [13849.208559] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13849.225712] alg: No test for adler32 (adler32-zlib) [13850.271278] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [13850.537602] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [13852.207158] Key type lgssc registered [13853.316393] Lustre: Echo OBD driver; http://www.lustre.org/ [13900.960620] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 16:39:25 (1786826365) [13912.382572] Key type lgssc unregistered [13912.610971] LNet: 297484:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13912.622151] LNetError: 297484:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13912.642773] LNet: Removed LNI 192.168.203.27@tcp [13913.265054] Key type .llcrypt unregistered [13913.268946] Key type ._llcrypt unregistered [13922.877759] Key type ._llcrypt registered [13922.885199] Key type .llcrypt registered [13923.372456] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13923.386700] alg: No test for adler32 (adler32-zlib) [13924.468050] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [13924.703695] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [13926.359198] Key type lgssc registered [13927.399152] Lustre: Echo OBD driver; http://www.lustre.org/ [13977.396903] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13982.628379] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14002.223839] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14258.820682] LNet: Added LNI 192.168.203.27@tcp50 [8/256/0/180] [14260.860695] LNet: Removed LNI 192.168.203.27@tcp [14262.950051] Lustre: 301889:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff956e52128800: config has no valid NIDs, force dynamic NIDs [14264.207782] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [14264.451104] Lustre: Unmounted lustre-client [14266.851642] Key type lgssc unregistered [14267.205913] LNet: 302152:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14267.218339] LNetError: 302152:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14267.234637] LNet: Removed LNI 192.168.203.27@tcp50 [14267.830116] Key type .llcrypt unregistered [14267.836785] Key type ._llcrypt unregistered [14284.804039] Key type ._llcrypt registered [14284.815279] Key type .llcrypt registered [14284.981983] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14284.995469] alg: No test for adler32 (adler32-zlib) [14285.988386] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [14286.152188] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [14287.783304] Key type lgssc registered [14288.809305] Lustre: Echo OBD driver; http://www.lustre.org/ [14352.804944] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14358.232729] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14364.966479] LNet: Added LNI 192.168.203.27@tcp50 [8/256/0/180] [14365.892441] LNet: Removed LNI 192.168.203.27@tcp [14367.111361] Lustre: 304845:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff956e428ed800: config has no valid NIDs, force dynamic NIDs [14368.307536] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [14368.894080] Lustre: Unmounted lustre-client [14400.125106] Key type lgssc unregistered [14400.444383] LNet: 305717:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14400.454079] LNetError: 305717:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14400.484043] LNet: Removed LNI 192.168.203.27@tcp50 [14401.079970] Key type .llcrypt unregistered [14401.083502] Key type ._llcrypt unregistered [14410.753774] Key type ._llcrypt registered [14410.757242] Key type .llcrypt registered [14411.921527] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 16:47:56 (1786826876) [14427.649667] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14427.715925] alg: No test for adler32 (adler32-zlib) [14428.820304] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [14429.114840] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [14430.823407] Key type lgssc registered [14431.749787] Lustre: Echo OBD driver; http://www.lustre.org/ [14497.376291] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14501.399417] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14520.484788] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14548.382848] Key type lgssc unregistered [14548.557693] LNet: 310467:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14548.564356] LNetError: 310467:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14548.578988] LNet: Removed LNI 192.168.203.27@tcp [14549.035165] Key type .llcrypt unregistered [14549.037487] Key type ._llcrypt unregistered [14557.029417] Key type ._llcrypt registered [14557.031507] Key type .llcrypt registered [14558.114391] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 16:50:23 (1786827023) [14559.726987] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14559.837208] alg: No test for adler32 (adler32-zlib) [14560.866425] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [14561.083049] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [14562.743217] Key type lgssc registered [14563.797797] Lustre: Echo OBD driver; http://www.lustre.org/ [14600.002408] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14604.255160] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14622.335297] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14628.377874] Lustre: Mounted lustre-client - version 2.17.57_2_gb7122c1 [14677.140154] Lustre: Mounted fs15246-client - version 2.17.57_2_gb7122c1 [14691.524479] Lustre: Unmounted fs15246-client [14716.171708] Lustre: Unmounted lustre-client [14752.913050] Key type lgssc unregistered [14753.209312] LNet: 315327:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14753.216948] LNetError: 315327:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14753.242209] LNet: Removed LNI 192.168.203.27@tcp [14753.832244] Key type .llcrypt unregistered [14753.834520] Key type ._llcrypt unregistered [14762.315875] Key type ._llcrypt registered [14762.319324] Key type .llcrypt registered [14763.412152] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 16:53:48 (1786827228) [14764.724508] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14764.752809] alg: No test for adler32 (adler32-zlib) [14765.814885] Lustre: Lustre: Build Version: 2.17.57_2_gb7122c1 [14765.997982] LNet: Added LNI 192.168.203.27@tcp [8/256/0/180] [14767.647618] Key type lgssc registered [14768.477534] Lustre: Echo OBD driver; http://www.lustre.org/ [14883.361695] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14888.391839] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14913.082206] Lustre: DEBUG MARKER: oleg327-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15023.626939] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 14769 sec ========= 16:58:08 (1786827488) [15024.829785] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 16:58:09 (1786827489) === [15028.605807] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 16:58:13 (1786827493) === [15061.020504] Key type lgssc unregistered [15061.301339] LNet: 324597:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15061.309452] LNetError: 324597:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15061.329687] LNet: Removed LNI 192.168.203.27@tcp [15061.902947] Key type .llcrypt unregistered [15061.905299] Key type ._llcrypt unregistered