[ 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 452023605 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001022] APIC: Switch to symmetric I/O mode setup [ 0.002240] x2apic enabled [ 0.003009] Switched APIC routing to physical x2apic. [ 0.004011] kvm-guest: setup PV IPIs [ 0.007000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.007022] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.008013] pid_max: default: 32768 minimum: 301 [ 0.009139] LSM: Security Framework initializing [ 0.010049] Yama: becoming mindful. [ 0.011039] SELinux: Initializing. [ 0.012066] *** VALIDATE selinux *** [ 0.020141] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024727] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.025156] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.026102] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028051] *** VALIDATE tmpfs *** [ 0.029426] *** VALIDATE proc *** [ 0.030218] *** VALIDATE cgroup *** [ 0.031009] *** VALIDATE cgroup2 *** [ 0.033150] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.034155] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.035007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.036031] Spectre V2 : User space: Vulnerable [ 0.037011] Speculative Store Bypass: Vulnerable [ 0.040438] debug: unmapping init [mem 0xffffffff91a59000-0xffffffff91a60fff] [ 0.043000] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043686] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044027] ... version: 2 [ 0.045011] ... bit width: 48 [ 0.046013] ... generic registers: 4 [ 0.047012] ... value mask: 0000ffffffffffff [ 0.048016] ... max period: 00007fffffffffff [ 0.049013] ... fixed-purpose events: 3 [ 0.050012] ... event mask: 000000070000000f [ 0.051297] rcu: Hierarchical SRCU implementation. [ 0.053432] smp: Bringing up secondary CPUs ... [ 0.054613] x86: Booting SMP configuration: [ 0.055032] .... node #0, CPUs: #1 #2 #3 [ 0.058327] smp: Brought up 1 node, 4 CPUs [ 0.060014] smpboot: Max logical packages: 1 [ 0.061018] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.144058] node 0 deferred pages initialised in 81ms [ 0.147406] devtmpfs: initialized [ 0.148305] x86/mm: Memory block size: 128MB [ 0.152883] gcov: version magic: 0x41383552 [ 0.155254] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.156080] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.158338] pinctrl core: initialized pinctrl subsystem [ 0.160207] [ 0.160695] ************************************************************* [ 0.163014] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.165010] ** ** [ 0.167012] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.169013] ** ** [ 0.171014] ** This means that this kernel is built to expose internal ** [ 0.173013] ** IOMMU data structures, which may compromise security on ** [ 0.175014] ** your system. ** [ 0.177010] ** ** [ 0.180014] ** If you see this message and you are not debugging the ** [ 0.182013] ** kernel, report this immediately to your vendor! ** [ 0.184013] ** ** [ 0.186020] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.188014] ************************************************************* [ 0.189620] NET: Registered protocol family 16 [ 0.192591] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.194070] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.197061] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.201136] cpuidle: using governor menu [ 0.204000] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.206575] PCI: Using configuration type 1 for base access [ 0.208120] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.217055] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.218019] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.220074] cryptd: max_cpu_qlen set to 1000 [ 0.223252] ACPI: Added _OSI(Module Device) [ 0.224020] ACPI: Added _OSI(Processor Device) [ 0.226016] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.227014] ACPI: Added _OSI(Processor Aggregator Device) [ 0.232402] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.238529] ACPI: Interpreter enabled [ 0.240075] ACPI: PM: (supports S0 S3 S4 S5) [ 0.242013] ACPI: Using IOAPIC for interrupt routing [ 0.244134] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.247450] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.258579] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.260043] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.263018] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.266084] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.270362] acpiphp: Slot [2] registered [ 0.272123] acpiphp: Slot [5] registered [ 0.273116] acpiphp: Slot [6] registered [ 0.274124] acpiphp: Slot [3] registered [ 0.276092] acpiphp: Slot [4] registered [ 0.277000] acpiphp: Slot [7] registered [ 0.278086] acpiphp: Slot [8] registered [ 0.279104] acpiphp: Slot [9] registered [ 0.280135] acpiphp: Slot [10] registered [ 0.282116] acpiphp: Slot [11] registered [ 0.283092] acpiphp: Slot [12] registered [ 0.284073] acpiphp: Slot [13] registered [ 0.285151] acpiphp: Slot [14] registered [ 0.286180] acpiphp: Slot [15] registered [ 0.288101] acpiphp: Slot [16] registered [ 0.289069] acpiphp: Slot [17] registered [ 0.290017] acpiphp: Slot [18] registered [ 0.291082] acpiphp: Slot [19] registered [ 0.292189] acpiphp: Slot [20] registered [ 0.294085] acpiphp: Slot [21] registered [ 0.295000] acpiphp: Slot [22] registered [ 0.295000] acpiphp: Slot [23] registered [ 0.296093] acpiphp: Slot [24] registered [ 0.298106] acpiphp: Slot [25] registered [ 0.299077] acpiphp: Slot [26] registered [ 0.300116] acpiphp: Slot [27] registered [ 0.301098] acpiphp: Slot [28] registered [ 0.303091] acpiphp: Slot [29] registered [ 0.304110] acpiphp: Slot [30] registered [ 0.305093] acpiphp: Slot [31] registered [ 0.306075] PCI host bridge to bus 0000:00 [ 0.308018] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.310021] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.312030] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.313025] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.315024] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.318026] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.320170] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.323413] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.326198] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.333014] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.338058] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.341021] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.343017] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.345021] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.347449] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.350871] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.352038] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.354837] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.359014] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.369018] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.373013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.378231] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.383018] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.392018] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.408018] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.415178] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.422017] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.427016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.442015] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.450474] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.452378] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.454234] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.456237] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.458226] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.461758] iommu: Default domain type: Passthrough [ 0.463393] SCSI subsystem initialized [ 0.465175] ACPI: bus type USB registered [ 0.466117] usbcore: registered new interface driver usbfs [ 0.468070] usbcore: registered new interface driver hub [ 0.470084] usbcore: registered new device driver usb [ 0.471275] pps_core: LinuxPPS API ver. 1 registered [ 0.473012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.477064] PTP clock support registered [ 0.479087] EDAC MC: Ver: 3.0.0 [ 0.480476] PCI: Using ACPI for IRQ routing [ 0.482596] NetLabel: Initializing [ 0.483009] NetLabel: domain hash size = 128 [ 0.483784] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.485085] NetLabel: unlabeled traffic allowed by default [ 0.487111] vgaarb: loaded [ 0.489242] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.490009] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.495853] clocksource: Switched to clocksource kvm-clock [ 0.589191] VFS: Disk quotas dquot_6.6.0 [ 0.590878] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.592513] *** VALIDATE ramfs *** [ 0.593735] *** VALIDATE hugetlbfs *** [ 0.595132] pnp: PnP ACPI init [ 0.597319] pnp: PnP ACPI: found 6 devices [ 0.612149] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.614641] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.616078] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.617631] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.619217] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.620800] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.622754] NET: Registered protocol family 2 [ 0.624643] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.628474] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.631810] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.636936] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.640191] TCP: Hash tables configured (established 65536 bind 65536) [ 0.643342] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.646586] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.649514] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.652591] NET: Registered protocol family 1 [ 0.655057] RPC: Registered named UNIX socket transport module. [ 0.657343] RPC: Registered udp transport module. [ 0.659127] RPC: Registered tcp transport module. [ 0.660841] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.663206] NET: Registered protocol family 44 [ 0.664121] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.665204] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.666304] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.667515] PCI: CLS 0 bytes, default 64 [ 0.668393] Unpacking initramfs... [ 2.061448] debug: unmapping init [mem 0xffff927efcc64000-0xffff927efffcffff] [ 2.065206] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.067828] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.070780] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.546871] Initialise system trusted keyrings [ 2.548030] Key type blacklist registered [ 2.549476] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.556435] zbud: loaded [ 2.559194] *** VALIDATE nfs *** [ 2.560048] *** VALIDATE nfs4 *** [ 2.561143] pstore: using deflate compression [ 2.563431] Platform Keyring initialized [ 2.672612] NET: Registered protocol family 38 [ 2.677803] Key type asymmetric registered [ 2.679070] Asymmetric key parser 'x509' registered [ 2.680214] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.682938] io scheduler mq-deadline registered [ 2.685298] io scheduler kyber registered [ 2.686982] io scheduler bfq registered [ 2.689436] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.693341] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.696750] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.699588] ACPI: Power Button [PWRF] [ 2.704991] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.712664] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.723882] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.751615] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.780399] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.785765] Non-volatile memory driver v1.3 [ 2.787659] Linux agpgart interface v0.103 [ 2.819978] virtio_blk virtio1: [vda] 146680 512-byte logical blocks (75.1 MB/71.6 MiB) [ 2.823325] vda: detected capacity change from 0 to 75100160 [ 2.844370] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.846366] vdb: detected capacity change from 0 to 1073741824 [ 2.856267] libphy: Fixed MDIO Bus: probed [ 2.864306] usbcore: registered new interface driver usbserial_generic [ 2.867232] usbserial: USB Serial support registered for generic [ 2.869830] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.874342] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.876317] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.880151] mousedev: PS/2 mouse device common for all mice [ 2.883075] rtc_cmos 00:05: RTC can wake from S4 [ 2.885631] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.886224] rtc_cmos 00:05: registered as rtc0 [ 2.889706] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.891391] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.892069] intel_pstate: CPU model not supported [ 2.896553] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.899344] hid: raw HID events driver (C) Jiri Kosina [ 2.902577] usbcore: registered new interface driver usbhid [ 2.904592] usbhid: USB HID core driver [ 2.906419] drop_monitor: Initializing network drop monitor service [ 2.909199] Initializing XFRM netlink socket [ 2.911348] NET: Registered protocol family 10 [ 2.914296] Segment Routing with IPv6 [ 2.915944] NET: Registered protocol family 17 [ 2.917985] mpls_gso: MPLS GSO support [ 2.924092] RAS: Correctable Errors collector initialized. [ 2.927348] AVX version of gcm_enc/dec engaged. [ 2.929172] AES CTR mode by8 optimization enabled [ 3.006968] sched_clock: Marking stable (3006936052, 0)->(3899004431, -892068379) [ 3.010271] registered taskstats version 1 [ 3.012479] Loading compiled-in X.509 certificates [ 3.014537] zswap: loaded using pool lzo/zbud [ 3.040614] Key type big_key registered [ 3.050654] Key type encrypted registered [ 3.052349] ima: No TPM chip found, activating TPM-bypass! [ 3.054554] ima: Allocated hash algorithm: sha1 [ 3.056353] ima: No architecture policies found [ 3.058217] evm: Initialising EVM extended attributes: [ 3.060248] evm: security.selinux [ 3.061434] evm: security.ima [ 3.062687] evm: security.capability [ 3.064025] evm: HMAC attrs: 0x1 [ 3.068280] rtc_cmos 00:05: setting system clock to 2026-09-13 11:08:18 UTC (1789297698) [ 3.074946] debug: unmapping init [mem 0xffffffff92a03000-0xffffffff92bfffff] [ 3.078251] debug: unmapping init [mem 0xffffffff91782000-0xffffffff91a58fff] [ 3.087109] Write protecting the kernel read-only data: 28672k [ 3.090454] debug: unmapping init [mem 0xffffffff8fe03000-0xffffffff8fffffff] [ 3.093264] debug: unmapping init [mem 0xffffffff90714000-0xffffffff907fffff] [ 3.128627] 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.136960] systemd[1]: Detected virtualization kvm. [ 3.139077] systemd[1]: Detected architecture x86-64. [ 3.141378] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.174501] systemd[1]: No hostname configured. [ 3.176227] systemd[1]: Set hostname to . [ 3.178384] random: systemd: uninitialized urandom read (16 bytes read) [ 3.180971] systemd[1]: Initializing machine ID from random generator. [ 3.231932] random: ln: uninitialized urandom read (6 bytes read) [ 3.311975] random: systemd: uninitialized urandom read (16 bytes read) [ 3.313728] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 3.316981] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.320254] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Sockets. [ OK ] Started Memstrack Anylazing Service. Starting Journal Service... [ OK ] Reached target Paths. [ OK ] Reached target Swap. Starting Setup Virtual Console... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ 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... [ OK ] Started Setup Virtual Console. [ OK ] Started Create Volatile Files and Directories. 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... [ 3.995957] device-mapper: uevent: version 1.0.3 [ 3.997669] 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.778619] random: fast init done [ 4.839149] virtio_net virtio0 ens2: renamed from eth0 [ 4.900969] scsi host0: ata_piix [ 4.987148] scsi host1: ata_piix [ 4.988754] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.991073] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.170875] dracut-initqueue[587]: RTNETLINK answers: File exists [ 9.574296] random: crng init done [ 9.575776] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 9.958337] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Swap. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.064512] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.300987] SELinux: Disabled at runtime. [ 11.359793] 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.367706] systemd[1]: Detected virtualization kvm. [ 11.369477] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.767897] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.770653] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.775148] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.778457] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.780371] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.787203] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.793494] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on Process Core Dump Socket. Mounting Kernel Debug File System... [ OK ] Listening on udev Control Socket. 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 ] Stopped target Switch Root. [ OK ] Listening on initctl Compatibility Named Pipe. Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Initrd Root File System. Activating swap /dev/disk/by-label/SWAP... [ OK ] Reached target rpc_pipefs.target. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Created slice User and Session Slice. [ OK ] Created slice system-getty.slice. [ OK ] Reached target Slices. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK [[ 11.889105] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS 0m] Stopped target Initrd File Systems. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. Starting Apply Kernel Variables... Mounting Huge Pages File System... [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ 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 ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Huge Pages File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.175711] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.408945] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.433880] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.566668] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.575996] EDAC sbridge: Ver: 1.1.2 [ 13.554362] Key type dns_resolver registered [ 13.853174] NFS: Registering the id_resolver key type [ 13.855171] Key type id_resolver registered [ 13.856777] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Load/Save Random Seed... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. 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 update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Login Service... [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. Starting Restore /run/initramfs on shutdown... [ OK ] Started Login Service. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ 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 oleg255-client login: [ 43.693084] libcfs: loading out-of-tree module taints kernel. [ 43.804837] Key type ._llcrypt registered [ 43.814781] Key type .llcrypt registered [ 44.003557] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 44.011422] alg: No test for adler32 (adler32-zlib) [ 45.056856] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 45.399433] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 47.031198] Key type lgssc registered [ 47.682693] Lustre: Echo OBD driver; http://www.lustre.org/ [ 208.944918] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 214.875110] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 228.446640] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing check_logdir /tmp/testlogs/ [ 234.482191] Lustre: lustre-OST0000-osc-ffff927f51cfc000: disconnect after 22s idle [ 236.947320] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing yml_node [ 241.545455] Lustre: DEBUG MARKER: Client: 2.17.57.106 [ 243.121298] hrtimer: interrupt took 3113256 ns [ 244.659577] Lustre: DEBUG MARKER: MDS: 2.17.57.106 [ 247.645179] Lustre: DEBUG MARKER: OSS: 2.17.57.106 [ 249.850554] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sun Sep 13 07:12:23 EDT 2026 [ 267.418251] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 269.038209] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 271.514241] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 281.835701] Lustre: Unmounted lustre-client [ 396.960108] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 402.773547] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 425.325536] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 462.058286] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 07:15:55 (1789298155) [ 465.082983] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 466.764331] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 07:16:00 (1789298160) [ 502.440416] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 508.856679] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 530.821713] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 531.572530] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 539.803840] Lustre: Unmounted lustre-client [ 567.543525] Key type lgssc unregistered [ 567.831984] LNet: 15024:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 567.838654] LNetError: 15024:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 567.860486] LNet: Removed LNI 192.168.202.55@tcp [ 568.531715] Key type .llcrypt unregistered [ 568.533917] Key type ._llcrypt unregistered [ 585.561488] Key type ._llcrypt registered [ 585.563312] Key type .llcrypt registered [ 587.062632] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 07:18:00 (1789298280) [ 589.414382] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 589.426917] alg: No test for adler32 (adler32-zlib) [ 590.645125] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 590.846320] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 592.543408] Key type lgssc registered [ 593.757711] Lustre: Echo OBD driver; http://www.lustre.org/ [ 674.383972] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 764.596827] Lustre: Unmounted lustre-client [ 795.591059] Key type lgssc unregistered [ 795.935560] LNet: 18813:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 795.944979] LNetError: 18813:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 795.958892] LNet: Removed LNI 192.168.202.55@tcp [ 796.813243] Key type .llcrypt unregistered [ 796.815355] Key type ._llcrypt unregistered [ 808.675181] Key type ._llcrypt registered [ 808.677665] Key type .llcrypt registered [ 810.090651] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 07:21:43 (1789298503) [ 812.600549] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 812.647618] alg: No test for adler32 (adler32-zlib) [ 813.713870] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 814.113254] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 815.855212] Key type lgssc registered [ 817.447724] Lustre: Echo OBD driver; http://www.lustre.org/ [ 871.007731] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 878.610221] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 901.339481] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 904.377702] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 916.345339] Lustre: Unmounted lustre-client [ 951.198738] Key type lgssc unregistered [ 951.462255] LNet: 22412:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 951.469320] LNetError: 22412:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 951.490344] LNet: Removed LNI 192.168.202.55@tcp [ 952.210579] Key type .llcrypt unregistered [ 952.214898] Key type ._llcrypt unregistered [ 965.560068] Key type ._llcrypt registered [ 965.563077] Key type .llcrypt registered [ 967.011542] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 07:24:20 (1789298660) [ 969.831438] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 969.843412] alg: No test for adler32 (adler32-zlib) [ 971.148900] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 971.578369] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 973.239197] Key type lgssc registered [ 974.765468] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1023.487794] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1028.604167] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1053.916242] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1056.708277] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 1062.065543] Lustre: Unmounted lustre-client [ 1087.795331] Key type lgssc unregistered [ 1088.068341] LNet: 25597:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1088.073323] LNetError: 25597:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1089.127962] LNet: Removed LNI 192.168.202.55@tcp [ 1089.890713] Key type .llcrypt unregistered [ 1089.892980] Key type ._llcrypt unregistered [ 1105.131525] Key type ._llcrypt registered [ 1105.133813] Key type .llcrypt registered [ 1106.225930] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 07:26:40 (1789298800) [ 1108.873372] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1108.887992] alg: No test for adler32 (adler32-zlib) [ 1109.824594] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 1110.027588] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 1111.679448] Key type lgssc registered [ 1112.977936] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1160.310755] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1167.318160] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1190.847449] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1192.658317] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 1198.072893] Lustre: lustre-MDT0000-mdc-ffff927f51e57000: Connection to lustre-MDT0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1218.533822] Lustre: lustre-MDT0001-mdc-ffff927f51e57000: Connection to lustre-MDT0001 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1224.584875] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1228.768510] Lustre: 26554:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789298908/real 1789298908] req@0000000060d50edb x1876215783758208/t0(0) o400->MGC192.168.202.155@tcp@192.168.202.155@tcp:26/25 lens 224/224 e 0 to 1 dl 1789298924 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1228.793635] LustreError: MGC192.168.202.155@tcp: Connection to MGS (at 192.168.202.155@tcp) was lost; in progress operations using this service will fail [ 1234.921419] Lustre: Unmounted lustre-client [ 1248.900788] Key type lgssc unregistered [ 1249.252053] LNet: 29248:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1249.262348] LNetError: 29248:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1249.282722] LNet: Removed LNI 192.168.202.55@tcp [ 1249.901889] Key type .llcrypt unregistered [ 1249.904506] Key type ._llcrypt unregistered [ 1265.830823] Key type ._llcrypt registered [ 1265.833806] Key type .llcrypt registered [ 1267.041895] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 07:29:21 (1789298961) [ 1270.032079] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1270.079135] alg: No test for adler32 (adler32-zlib) [ 1271.275281] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 1271.498343] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 1273.183270] Key type lgssc registered [ 1274.366201] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1322.513427] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1328.302154] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1354.223493] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1355.969303] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 1361.400961] Lustre: lustre-OST0000-osc-ffff927f44c34800: Connection to lustre-OST0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1377.481492] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1387.832928] Lustre: Unmounted lustre-client [ 1415.469406] Key type lgssc unregistered [ 1415.771139] LNet: 32862:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1415.779158] LNetError: 32862:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1416.808917] LNet: Removed LNI 192.168.202.55@tcp [ 1417.822477] Key type .llcrypt unregistered [ 1417.825825] Key type ._llcrypt unregistered [ 1434.829223] Key type ._llcrypt registered [ 1434.831626] Key type .llcrypt registered [ 1436.040177] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 07:32:10 (1789299130) [ 1438.022532] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1438.133313] alg: No test for adler32 (adler32-zlib) [ 1439.322642] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 1439.484605] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 1441.103209] Key type lgssc registered [ 1442.662193] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1498.356656] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1505.369732] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1528.852676] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1541.173564] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 1545.430486] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1550.768984] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1562.676622] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-13 7h34m16s [ 1565.074673] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1571.813978] Lustre: lustre-MDT0000-mdc-ffff927f45687800: Connection to lustre-MDT0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1575.607816] LustreError: 36647:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff927f45687800: can't stat MDS #0: rc = -19 [ 1577.297354] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1585.129568] LustreError: MGC192.168.202.155@tcp: Connection to MGS (at 192.168.202.155@tcp) was lost; in progress operations using this service will fail [ 1585.165046] Lustre: Evicted from MGS (at 192.168.202.155@tcp) after server handle changed from 0xcb5e8ade2c183c80 to 0xcb5e8ade2c183e9b [ 1585.172934] Lustre: MGC192.168.202.155@tcp: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 1591.273474] LustreError: lustre-MDT0000-mdc-ffff927f45687800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1591.290893] Lustre: lustre-MDT0000-mdc-ffff927f45687800: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 1593.454154] Lustre: DEBUG MARKER: Wait for df (36647) ... [ 1595.275129] Lustre: DEBUG MARKER: done [ 1597.831562] Lustre: Unmounted lustre-client [ 1628.266186] Key type lgssc unregistered [ 1628.536928] LNet: 37663:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1628.540462] LNetError: 37663:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1628.556433] LNet: Removed LNI 192.168.202.55@tcp [ 1629.411024] Key type .llcrypt unregistered [ 1629.419930] Key type ._llcrypt unregistered [ 1663.682856] Key type ._llcrypt registered [ 1663.684869] Key type .llcrypt registered [ 1665.058942] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 07:35:58 (1789299358) [ 1668.373133] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1668.389596] alg: No test for adler32 (adler32-zlib) [ 1669.550152] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 1669.880475] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 1671.567269] Key type lgssc registered [ 1672.897778] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1731.406172] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1737.826639] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1762.338446] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1765.164167] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 1770.028529] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-13 7h37m43s [ 1771.978489] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1779.279837] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1782.073715] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1802.720695] Lustre: 41812:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789299477/real 1789299477] req@00000000137b4690 x1876216370961152/t0(0) o101->lustre-MDT0000-mdc-ffff927f47241000@192.168.202.155@tcp:12/10 lens 576/1152 e 0 to 1 dl 1789299497 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1802.755958] Lustre: lustre-MDT0000-mdc-ffff927f47241000: Connection to lustre-MDT0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1802.822910] Lustre: lustre-MDT0000-mdc-ffff927f47241000: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 1824.188120] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1827.799956] Lustre: DEBUG MARKER: done [ 1832.199400] Lustre: Unmounted lustre-client [ 1860.620168] Key type lgssc unregistered [ 1860.956484] LNet: 42688:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1860.967648] LNetError: 42688:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1860.988598] LNet: Removed LNI 192.168.202.55@tcp [ 1861.782074] Key type .llcrypt unregistered [ 1861.784855] Key type ._llcrypt unregistered [ 1897.059072] Key type ._llcrypt registered [ 1897.060802] Key type .llcrypt registered [ 1898.759558] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 07:39:52 (1789299592) [ 1900.574633] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1902.291631] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 07:39:56 (1789299596) [ 1907.003254] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1907.085123] alg: No test for adler32 (adler32-zlib) [ 1908.371662] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 1908.861870] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 1910.679377] Key type lgssc registered [ 1912.627639] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1948.429367] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 07:40:42 (1789299642) [ 1982.778765] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1988.195855] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2012.717689] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2016.027857] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 2021.101866] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2026.232626] Lustre: Unmounted lustre-client [ 2054.383221] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2103.742232] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2110.587525] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2111.188068] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 2115.357608] Lustre: Unmounted lustre-client [ 2183.759458] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2191.419175] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2192.198043] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 2198.369390] Lustre: Unmounted lustre-client [ 2222.357190] Lustre: DEBUG MARKER: files compared the same [ 2245.008821] Key type lgssc unregistered [ 2245.263880] LNet: 50313:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2245.276317] LNetError: 50313:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2245.311316] LNet: Removed LNI 192.168.202.55@tcp [ 2246.151927] Key type .llcrypt unregistered [ 2246.156824] Key type ._llcrypt unregistered [ 2261.598562] Key type ._llcrypt registered [ 2261.600316] Key type .llcrypt registered [ 2263.004461] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 07:45:56 (1789299956) [ 2265.679906] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2265.789689] alg: No test for adler32 (adler32-zlib) [ 2266.905677] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 2267.254336] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 2269.031333] Key type lgssc registered [ 2270.710730] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2321.611869] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2328.552216] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2352.344324] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2354.989462] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 2359.420866] Lustre: Unmounted lustre-client [ 2387.589222] Key type lgssc unregistered [ 2387.826572] LNet: 53891:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2387.831168] LNetError: 53891:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2387.848315] LNet: Removed LNI 192.168.202.55@tcp [ 2388.676496] Key type .llcrypt unregistered [ 2388.677934] Key type ._llcrypt unregistered [ 2408.308824] Key type ._llcrypt registered [ 2408.311345] Key type .llcrypt registered [ 2410.122641] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 07:48:23 (1789300103) [ 2412.288781] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2412.373624] alg: No test for adler32 (adler32-zlib) [ 2413.709376] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 2414.155910] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 2416.015279] Key type lgssc registered [ 2417.294941] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2501.692664] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2535.764751] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2542.304285] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2569.990972] Key type lgssc unregistered [ 2570.277302] LNet: 57375:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2570.289740] LNetError: 57375:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2570.328861] LNet: Removed LNI 192.168.202.55@tcp [ 2571.153528] Key type .llcrypt unregistered [ 2571.156041] Key type ._llcrypt unregistered [ 2588.040381] Key type ._llcrypt registered [ 2588.043407] Key type .llcrypt registered [ 2589.565916] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 07:51:23 (1789300283) [ 2594.643238] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2594.660877] alg: No test for adler32 (adler32-zlib) [ 2595.715716] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 2595.990434] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 2597.735186] Key type lgssc registered [ 2599.071323] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2675.618774] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 2682.949292] Lustre: Unmounted lustre-client [ 2721.424695] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 07:53:35 (1789300415) [ 2857.496911] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2879.552339] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 2886.627457] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2886.641958] LustreError: 63847:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff927f58ac4000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2886.670297] Lustre: 58360:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.155@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2897.069963] Lustre: Unmounted lustre-client [ 2956.067497] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 07:57:30 (1789300650) [ 2968.318097] Key type lgssc unregistered [ 2968.743124] LNet: 65061:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2968.746870] LNetError: 65061:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2968.779129] LNet: Removed LNI 192.168.202.55@tcp [ 2969.556495] Key type .llcrypt unregistered [ 2969.559684] Key type ._llcrypt unregistered [ 2982.742550] Key type ._llcrypt registered [ 2982.745138] Key type .llcrypt registered [ 2983.401678] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2983.415788] alg: No test for adler32 (adler32-zlib) [ 2984.628721] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 2984.862471] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 2986.632263] Key type lgssc registered [ 2988.135365] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3039.715832] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3045.443482] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3067.389638] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3069.118880] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 3076.850550] Lustre: Unmounted lustre-client [ 3110.762621] Key type lgssc unregistered [ 3111.055794] LNet: 68073:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3111.062624] LNetError: 68073:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3111.079257] LNet: Removed LNI 192.168.202.55@tcp [ 3111.801300] Key type .llcrypt unregistered [ 3111.803339] Key type ._llcrypt unregistered [ 3122.050630] Key type ._llcrypt registered [ 3122.061146] Key type .llcrypt registered [ 3122.902141] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3122.929842] alg: No test for adler32 (adler32-zlib) [ 3124.137135] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 3124.567579] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 3126.375611] Key type lgssc registered [ 3127.922589] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3256.247666] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3262.154836] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3284.274371] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3295.266096] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 3299.248654] Lustre: Unmounted lustre-client [ 3328.587272] Key type lgssc unregistered [ 3328.927862] LNet: 71517:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3328.937360] LNetError: 71517:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3328.970412] LNet: Removed LNI 192.168.202.55@tcp [ 3330.041444] Key type .llcrypt unregistered [ 3330.044638] Key type ._llcrypt unregistered [ 3348.375930] Key type ._llcrypt registered [ 3348.379536] Key type .llcrypt registered [ 3349.864780] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 08:04:03 (1789301043) [ 3352.910132] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3352.951178] alg: No test for adler32 (adler32-zlib) [ 3353.988956] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 3354.261756] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 3355.943363] Key type lgssc registered [ 3357.056759] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3411.339714] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3419.520958] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3445.658930] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3457.561633] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 3466.108775] Lustre: Unmounted lustre-client [ 3466.805930] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 3469.878972] Lustre: Unmounted lustre-client [ 3497.779350] Key type lgssc unregistered [ 3498.040510] LNet: 75200:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3498.049949] LNetError: 75200:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3498.072419] LNet: Removed LNI 192.168.202.55@tcp [ 3498.744164] Key type .llcrypt unregistered [ 3498.747469] Key type ._llcrypt unregistered [ 3510.720736] Key type ._llcrypt registered [ 3510.722515] Key type .llcrypt registered [ 3511.388785] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3511.409238] alg: No test for adler32 (adler32-zlib) [ 3512.478703] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 3512.776841] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 3514.527229] Key type lgssc registered [ 3515.880298] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3570.650439] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3576.936543] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3598.093460] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3600.020680] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 3607.706681] Lustre: Unmounted lustre-client [ 3646.263661] Key type lgssc unregistered [ 3646.581736] LNet: 78242:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3646.596635] LNetError: 78242:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3646.615638] LNet: Removed LNI 192.168.202.55@tcp [ 3647.221335] Key type .llcrypt unregistered [ 3647.224643] Key type ._llcrypt unregistered [ 3667.118110] Key type ._llcrypt registered [ 3667.121144] Key type .llcrypt registered [ 3668.617236] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 08:09:22 (1789301362) [ 3670.733227] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3670.743583] alg: No test for adler32 (adler32-zlib) [ 3671.704224] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 3671.895452] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 3673.527223] Key type lgssc registered [ 3674.652249] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3730.047549] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3736.237110] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3759.044584] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3760.759259] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 3769.175591] Lustre: lustre: root_squash is set to 0:0 [ 3775.602900] Lustre: lustre: nosquash_nids is cleared [ 3783.220625] Lustre: lustre: root_squash is set to 500:500 [ 3798.136520] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.55@tcp 192.168.0.[2,10]@tcp [ 3805.305993] Lustre: lustre: nosquash_nids set to 192.168.202.55/24@tcp [ 3810.182274] Lustre: Unmounted lustre-client [ 3838.598711] Key type lgssc unregistered [ 3838.829991] LNet: 82204:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3838.835592] LNetError: 82204:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3838.848732] LNet: Removed LNI 192.168.202.55@tcp [ 3839.747501] Key type .llcrypt unregistered [ 3839.751490] Key type ._llcrypt unregistered [ 3858.003463] Key type ._llcrypt registered [ 3858.006471] Key type .llcrypt registered [ 3859.798598] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 08:12:33 (1789301553) [ 3863.219726] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3865.907219] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 08:12:39 (1789301559) [ 3868.515921] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3868.550657] alg: No test for adler32 (adler32-zlib) [ 3869.777199] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 3870.207387] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 3871.961663] Key type lgssc registered [ 3873.358811] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3926.544953] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3932.669747] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3955.173316] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3955.843771] Lustre: lustre: root_squash is set to 500:500 [ 3955.899744] Lustre: lustre: nosquash_nids set to 192.168.202.55/24@tcp [ 3957.002632] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 3966.427810] Lustre: Unmounted lustre-client [ 3997.024824] Key type lgssc unregistered [ 3997.479894] LNet: 86156:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3997.497592] LNetError: 86156:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3997.530429] LNet: Removed LNI 192.168.202.55@tcp [ 3998.757360] Key type .llcrypt unregistered [ 3998.759597] Key type ._llcrypt unregistered [ 4020.779829] Key type ._llcrypt registered [ 4020.783495] Key type .llcrypt registered [ 4022.535295] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4024.491545] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 08:15:18 (1789301718) [ 4049.061242] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4049.097154] alg: No test for adler32 (adler32-zlib) [ 4050.179680] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 4050.500996] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 4052.239264] Key type lgssc registered [ 4053.749694] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4157.702485] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4163.645683] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4187.875333] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4256.895862] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4263.431730] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4292.055228] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4305.091563] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 4340.989819] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff927f46ffe800.ost_server_uuid 50 [ 4342.537512] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff927f46ffe800.ost_server_uuid in IDLE state after 0 sec [ 4343.160479] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 4346.870783] Lustre: Unmounted lustre-client [ 4349.279627] Lustre: Unmounted lustre-client [ 4408.547389] Key type lgssc unregistered [ 4408.894734] LNet: 93827:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4408.909193] LNetError: 93827:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4409.958767] LNet: Removed LNI 192.168.202.55@tcp [ 4410.965231] Key type .llcrypt unregistered [ 4410.971723] Key type ._llcrypt unregistered [ 4445.460485] Key type ._llcrypt registered [ 4445.464713] Key type .llcrypt registered [ 4446.829366] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 08:22:20 (1789302140) [ 4467.797158] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4467.814740] alg: No test for adler32 (adler32-zlib) [ 4468.985736] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 4469.413027] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 4471.183241] Key type lgssc registered [ 4472.754917] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4561.363517] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4567.665415] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4595.726421] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4598.569059] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 4620.066586] Lustre: 95190:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789302299/real 1789302299] req@00000000731f582a x1876219305923840/t0(0) o400->lustre-OST0000-osc-ffff927f51e57800@192.168.202.155@tcp:28/4 lens 224/224 e 0 to 1 dl 1789302315 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4620.101745] Lustre: lustre-OST0000-osc-ffff927f51e57800: Connection to lustre-OST0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4625.376192] Lustre: 95189:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789302304/real 1789302304] req@00000000950ac492 x1876219305924352/t0(0) o400->lustre-OST0000-osc-ffff927f51e57800@192.168.202.155@tcp:28/4 lens 224/224 e 0 to 1 dl 1789302320 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4630.539649] Lustre: 95189:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789302309/real 1789302309] req@00000000ce696b03 x1876219305924864/t0(0) o400->lustre-OST0000-osc-ffff927f51e57800@192.168.202.155@tcp:28/4 lens 224/224 e 0 to 1 dl 1789302325 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4630.606563] Lustre: lustre-OST0000-osc-ffff927f51e57800: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 4634.723086] Lustre: 95189:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789302314/real 1789302314] req@00000000376e0a0b x1876219305925376/t0(0) o400->lustre-OST0000-osc-ffff927f51e57800@192.168.202.155@tcp:28/4 lens 224/224 e 0 to 1 dl 1789302330 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4640.772868] Lustre: lustre-MDT0000-mdc-ffff927f51e57800: Connection to lustre-MDT0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4657.120578] Lustre: 95190:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789302336/real 1789302336] req@000000009111621d x1876219305928192/t0(0) o400->MGC192.168.202.155@tcp@192.168.202.155@tcp:26/25 lens 224/224 e 0 to 1 dl 1789302352 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4657.154454] LustreError: MGC192.168.202.155@tcp: Connection to MGS (at 192.168.202.155@tcp) was lost; in progress operations using this service will fail [ 4667.381062] Lustre: Evicted from MGS (at 192.168.202.155@tcp) after server handle changed from 0xf7dcf93c518b5917 to 0xf7dcf93c518b5aad [ 4667.419378] Lustre: MGC192.168.202.155@tcp: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 4674.973651] Lustre: lustre-MDT0000-mdc-ffff927f51e57800: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 4680.059434] Lustre: Unmounted lustre-client [ 4706.447991] Key type lgssc unregistered [ 4706.827959] LNet: 99495:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4706.851237] LNetError: 99495:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4707.880698] LNet: Removed LNI 192.168.202.55@tcp [ 4709.012395] Key type .llcrypt unregistered [ 4709.016566] Key type ._llcrypt unregistered [ 4725.479430] Key type ._llcrypt registered [ 4725.482221] Key type .llcrypt registered [ 4726.600047] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 08:27:00 (1789302420) [ 4740.865880] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4740.884553] alg: No test for adler32 (adler32-zlib) [ 4742.119764] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 4742.458453] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 4744.175173] Key type lgssc registered [ 4745.632431] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4788.335167] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4894.346210] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4901.769045] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4925.783495] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4928.426859] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 4930.134416] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4931.808161] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 08:30:25 (1789302625) [ 5169.045877] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5179.363028] Lustre: Unmounted lustre-client [ 5295.137286] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5301.538931] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5329.517941] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5376.387170] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 08:37:50 (1789303070) [ 5475.985880] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5483.034300] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5509.637515] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5510.246332] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 5515.003325] Lustre: Unmounted lustre-client [ 5546.411479] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 08:40:40 (1789303240) [ 5648.541522] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5654.505471] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5682.495397] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5683.297714] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 5688.848844] Lustre: Unmounted lustre-client [ 5716.106576] Key type lgssc unregistered [ 5716.297979] LNet: 122527:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5716.303682] LNetError: 122527:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5717.353300] LNet: Removed LNI 192.168.202.55@tcp [ 5718.081274] Key type .llcrypt unregistered [ 5718.086522] Key type ._llcrypt unregistered [ 5734.411566] Key type ._llcrypt registered [ 5734.413197] Key type .llcrypt registered [ 5735.477910] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 08:43:49 (1789303429) [ 5738.028944] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5738.052841] alg: No test for adler32 (adler32-zlib) [ 5739.253853] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 5739.489399] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 5741.175192] Key type lgssc registered [ 5742.415691] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5792.342788] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5799.146390] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5826.754213] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5829.505143] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 5842.504317] Lustre: Unmounted lustre-client [ 5873.620500] Key type lgssc unregistered [ 5873.852914] LNet: 126122:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5873.862266] LNetError: 126122:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5873.877137] LNet: Removed LNI 192.168.202.55@tcp [ 5874.694114] Key type .llcrypt unregistered [ 5874.697161] Key type ._llcrypt unregistered [ 5893.083164] Key type ._llcrypt registered [ 5893.084858] Key type .llcrypt registered [ 5894.608718] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 08:46:28 (1789303588) [ 5897.053632] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5897.062908] alg: No test for adler32 (adler32-zlib) [ 5898.027683] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 5898.155736] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 5899.815205] Key type lgssc registered [ 5900.797439] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5959.161256] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5965.060392] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5986.328859] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5989.361291] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 5999.591767] Lustre: lustre-OST0000-osc-ffff927f60347000: Connection to lustre-OST0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6019.646591] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff927f60347000.ost_server_uuid 50 [ 6021.645334] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6032.587860] Lustre: Unmounted lustre-client [ 6054.150686] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 08:49:07 (1789303747) [ 6087.784175] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6094.344391] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6120.640631] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6149.138400] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6150.122185] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 6155.241732] Lustre: lustre-OST0000-osc-ffff927f581de800: Connection to lustre-OST0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6182.118360] Lustre: Unmounted lustre-client [ 6232.265626] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 08:52:06 (1789303926) [ 6266.055053] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6272.815603] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6296.425629] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6318.666679] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6319.381949] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 6324.719363] Lustre: lustre-OST0000-osc-ffff927f4775b000: Connection to lustre-OST0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6340.890140] Lustre: Unmounted lustre-client [ 6400.590869] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 08:54:54 (1789304094) [ 6505.971324] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6513.461877] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6539.891347] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6609.711557] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6617.182910] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6641.850201] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6672.659056] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 6715.423688] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6720.157907] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 6721.801152] Lustre: Unmounted lustre-client [ 6754.548739] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 09:00:48 (1789304448) [ 6786.611568] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6792.972231] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6813.958191] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6848.039230] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6880.127596] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 6926.380983] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6928.168556] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6949.458385] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6959.814624] Lustre: Unmounted lustre-client [ 7013.548344] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 09:05:07 (1789304707) [ 7051.710596] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7057.694333] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7079.980687] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7080.918961] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 7106.989506] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7109.046817] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7125.787811] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff927f448fb800.ost_server_uuid 50 [ 7128.053693] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff927f448fb800.ost_server_uuid in IDLE state after 0 sec [ 7132.030993] Lustre: Unmounted lustre-client [ 7132.556913] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7132.563526] Lustre: Skipped 3 previous similar messages [ 7132.686383] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 7133.894161] LustreError: 149578:0:(sec.c:403:import_sec_validate_get()) import 000000005ebebc7d (NEW) with no sec [ 7193.543282] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 09:08:07 (1789304887) [ 7229.513835] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7235.239210] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7257.130640] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7278.669478] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7279.442717] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7279.567963] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 7295.523642] Lustre: Unmounted lustre-client [ 7295.528016] Lustre: Skipped 1 previous similar message [ 7333.634917] Key type lgssc unregistered [ 7333.856453] LNet: 153011:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7333.860450] LNetError: 153011:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7334.886764] LNet: Removed LNI 192.168.202.55@tcp [ 7335.625430] Key type .llcrypt unregistered [ 7335.633468] Key type ._llcrypt unregistered [ 7353.001117] Key type ._llcrypt registered [ 7353.007523] Key type .llcrypt registered [ 7354.850122] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 09:10:48 (1789305048) [ 7356.066626] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7356.086210] alg: No test for adler32 (adler32-zlib) [ 7357.084696] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 7357.387323] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 7359.063227] Key type lgssc registered [ 7360.429570] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7412.702750] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7418.867541] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7435.955990] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7457.115492] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7458.725040] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7459.855283] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 7466.535507] LustreError: lustre-MDT0001-mdc-ffff927f44c30000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7466.569953] Lustre: lustre-MDT0001-mdc-ffff927f44c30000: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 7472.884710] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7474.828675] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7496.201596] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7499.778208] Lustre: Unmounted lustre-client [ 7519.905294] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 09:13:34 (1789305214) [ 7600.787303] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7606.206290] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7626.635733] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7627.044296] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 7651.648467] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7653.052731] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7663.655599] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7673.952916] Lustre: Unmounted lustre-client [ 7705.510647] Key type lgssc unregistered [ 7705.774254] LNet: 162606:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7705.778414] LNetError: 162606:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7705.801751] LNet: Removed LNI 192.168.202.55@tcp [ 7706.420221] Key type .llcrypt unregistered [ 7706.422685] Key type ._llcrypt unregistered [ 7737.003603] Key type ._llcrypt registered [ 7737.005617] Key type .llcrypt registered [ 7738.156894] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 09:17:12 (1789305432) [ 7740.183346] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7740.206959] alg: No test for adler32 (adler32-zlib) [ 7741.319137] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 7741.582541] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 7743.287156] Key type lgssc registered [ 7744.186489] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7785.562602] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7790.971155] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7809.957905] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7812.644882] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 7859.290490] Lustre: Unmounted lustre-client [ 7893.667678] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7894.157864] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 7929.989204] Lustre: Unmounted lustre-client [ 7955.623981] Key type lgssc unregistered [ 7955.893972] LNet: 167040:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7955.899957] LNetError: 167040:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7955.915459] LNet: Removed LNI 192.168.202.55@tcp [ 7956.496311] Key type .llcrypt unregistered [ 7956.499902] Key type ._llcrypt unregistered [ 7969.139636] Key type ._llcrypt registered [ 7969.142306] Key type .llcrypt registered [ 7970.229644] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 09:21:04 (1789305664) [ 7972.455105] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7972.476983] alg: No test for adler32 (adler32-zlib) [ 7973.445440] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 7973.653080] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 7975.295600] Key type lgssc registered [ 7976.235135] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8017.786703] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8023.156352] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8039.591706] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8046.667036] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 8062.561700] Lustre: Unmounted lustre-client [ 8089.456312] Key type lgssc unregistered [ 8089.825948] LNet: 170784:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8089.831988] LNetError: 170784:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8089.864918] LNet: Removed LNI 192.168.202.55@tcp [ 8090.430538] Key type .llcrypt unregistered [ 8090.432271] Key type ._llcrypt unregistered [ 8101.278374] Key type ._llcrypt registered [ 8101.281992] Key type .llcrypt registered [ 8101.691931] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8101.700473] alg: No test for adler32 (adler32-zlib) [ 8102.775816] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 8103.075579] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 8104.735348] Key type lgssc registered [ 8105.737188] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8145.791620] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8150.000086] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8166.861817] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8172.591237] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 8178.741646] Lustre: Unmounted lustre-client [ 8204.010782] Key type lgssc unregistered [ 8204.211800] LNet: 173835:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8204.215572] LNetError: 173835:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8204.228934] LNet: Removed LNI 192.168.202.55@tcp [ 8204.763031] Key type .llcrypt unregistered [ 8204.764146] Key type ._llcrypt unregistered [ 8218.581465] Key type ._llcrypt registered [ 8218.583120] Key type .llcrypt registered [ 8219.542737] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 09:25:13 (1789305913) [ 8221.817414] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8221.837392] alg: No test for adler32 (adler32-zlib) [ 8222.911561] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 8223.109282] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 8224.754174] Key type lgssc registered [ 8225.814773] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8266.989121] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8271.633386] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8286.271818] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8292.914639] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 8307.127263] Lustre: Unmounted lustre-client [ 8339.436259] Key type lgssc unregistered [ 8339.657108] LNet: 177577:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8339.660691] LNetError: 177577:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8339.682344] LNet: Removed LNI 192.168.202.55@tcp [ 8340.258710] Key type .llcrypt unregistered [ 8340.263170] Key type ._llcrypt unregistered [ 8349.992965] Key type ._llcrypt registered [ 8349.997923] Key type .llcrypt registered [ 8350.392701] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8350.413555] alg: No test for adler32 (adler32-zlib) [ 8351.417950] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 8351.622317] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 8353.271203] Key type lgssc registered [ 8354.201847] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8392.731336] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8397.012743] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8412.769226] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8418.322427] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 8423.732164] Lustre: Unmounted lustre-client [ 8447.218434] Key type lgssc unregistered [ 8447.401057] LNet: 180631:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8447.405570] LNetError: 180631:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8447.422899] LNet: Removed LNI 192.168.202.55@tcp [ 8447.961606] Key type .llcrypt unregistered [ 8447.964845] Key type ._llcrypt unregistered [ 8458.364369] Key type ._llcrypt registered [ 8458.366286] Key type .llcrypt registered [ 8459.300818] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 09:29:13 (1789306153) [ 8474.853935] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8474.865058] alg: No test for adler32 (adler32-zlib) [ 8475.853368] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 8476.042591] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 8477.679289] Key type lgssc registered [ 8478.553943] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8534.179558] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8538.349836] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8553.931357] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8587.644523] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 09:31:22 (1789306282) [ 8612.461121] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8616.816276] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8635.526576] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8642.077532] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 8646.171778] Lustre: Unmounted lustre-client [ 8667.680577] Key type lgssc unregistered [ 8667.903920] LNet: 187717:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8667.911367] LNetError: 187717:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8667.926693] LNet: Removed LNI 192.168.202.55@tcp [ 8668.594305] Key type .llcrypt unregistered [ 8668.595715] Key type ._llcrypt unregistered [ 8681.006937] Key type ._llcrypt registered [ 8681.008297] Key type .llcrypt registered [ 8681.877139] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8683.027796] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 09:32:57 (1789306377) [ 8695.707472] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8695.807107] alg: No test for adler32 (adler32-zlib) [ 8696.787450] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 8696.940451] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 8698.568809] Key type lgssc registered [ 8699.539492] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8765.671651] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8769.289930] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8786.061721] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8800.380636] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8802.824667] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 8818.825729] Lustre: Unmounted lustre-client [ 8922.814668] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8926.262254] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8941.147377] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8970.967540] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 09:37:45 (1789306665) [ 8972.095474] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8973.316573] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 09:37:47 (1789306667) [ 9037.664361] Key type lgssc unregistered [ 9037.808958] LNet: 199135:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9037.815767] LNetError: 199135:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9037.826669] LNet: Removed LNI 192.168.202.55@tcp [ 9038.206312] Key type .llcrypt unregistered [ 9038.207959] Key type ._llcrypt unregistered [ 9047.572816] Key type ._llcrypt registered [ 9047.573986] Key type .llcrypt registered [ 9048.231770] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 09:39:02 (1789306742) [ 9080.052875] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9080.068082] alg: No test for adler32 (adler32-zlib) [ 9081.076990] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 9081.275534] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 9082.911447] Key type lgssc registered [ 9083.797181] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9115.485647] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9119.715090] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9146.593516] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9167.342747] Key type lgssc unregistered [ 9167.496344] LNet: 202855:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9167.499124] LNetError: 202855:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9167.506940] LNet: Removed LNI 192.168.202.55@tcp [ 9167.858092] Key type .llcrypt unregistered [ 9167.860090] Key type ._llcrypt unregistered [ 9176.210442] Key type ._llcrypt registered [ 9176.213358] Key type .llcrypt registered [ 9176.829155] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 09:41:11 (1789306871) [ 9178.009467] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9178.048339] alg: No test for adler32 (adler32-zlib) [ 9178.955110] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 9179.083932] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 9180.679186] Key type lgssc registered [ 9181.287726] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9207.441177] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9210.324179] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9222.602131] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9225.051525] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 9235.427503] Lustre: lustre-MDT0000-mdc-ffff927f44c30000: Connection to lustre-MDT0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9240.553749] Lustre: lustre-MDT0001-mdc-ffff927f44c30000: Connection to lustre-MDT0001 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9255.711213] Lustre: 203864:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789306935/real 1789306935] req@00000000ded4b236 x1876224244793600/t0(0) o400->MGC192.168.202.155@tcp@192.168.202.155@tcp:26/25 lens 224/224 e 0 to 1 dl 1789306951 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9255.725901] LustreError: MGC192.168.202.155@tcp: Connection to MGS (at 192.168.202.155@tcp) was lost; in progress operations using this service will fail [ 9266.149864] Lustre: Evicted from MGS (at 192.168.202.155@tcp) after server handle changed from 0xa5bf08d00bb9492c to 0xa5bf08d00bb9641b [ 9266.159382] Lustre: MGC192.168.202.155@tcp: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 9276.481343] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9281.511396] LustreError: lustre-MDT0000-mdc-ffff927f44c30000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9281.536955] Lustre: lustre-MDT0000-mdc-ffff927f44c30000: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 9282.491662] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 5 sec [ 9285.875958] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9286.829932] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9287.957508] Lustre: Unmounted lustre-client [ 9308.297985] Key type lgssc unregistered [ 9308.436407] LNet: 207844:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9308.439955] LNetError: 207844:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9308.450023] LNet: Removed LNI 192.168.202.55@tcp [ 9308.768913] Key type .llcrypt unregistered [ 9308.770627] Key type ._llcrypt unregistered [ 9318.317498] Key type ._llcrypt registered [ 9318.318961] Key type .llcrypt registered [ 9318.999549] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 09:43:33 (1789307013) [ 9320.352855] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9320.361829] alg: No test for adler32 (adler32-zlib) [ 9321.267901] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 9321.433632] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 9323.063176] Key type lgssc registered [ 9323.741760] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9350.938738] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9354.122730] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9384.075395] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9386.627483] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9404.816399] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9417.236199] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9441.929965] Key type lgssc unregistered [ 9442.068826] LNet: 213118:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9442.075104] LNetError: 213118:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9442.087526] LNet: Removed LNI 192.168.202.55@tcp [ 9442.400772] Key type .llcrypt unregistered [ 9442.402167] Key type ._llcrypt unregistered [ 9469.595285] Key type ._llcrypt registered [ 9469.596575] Key type .llcrypt registered [ 9470.230957] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 09:46:04 (1789307164) [ 9487.667553] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9487.703087] alg: No test for adler32 (adler32-zlib) [ 9488.585467] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 9488.690813] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 9490.279237] Key type lgssc registered [ 9490.804687] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9533.744553] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9536.211045] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9548.006316] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9574.445255] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 09:47:49 (1789307269) [ 9578.266480] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 09:47:52 (1789307272) [ 9595.696892] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9598.371715] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9608.279673] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9610.578213] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 9617.938509] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9618.714299] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9619.414544] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9620.065280] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9620.964456] Lustre: lustre-MDT0000-mdc-ffff927f50e7e800: Connection to lustre-MDT0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9636.326742] LustreError: MGC192.168.202.155@tcp: Connection to MGS (at 192.168.202.155@tcp) was lost; in progress operations using this service will fail [ 9636.353825] Lustre: Evicted from MGS (at 192.168.202.155@tcp) after server handle changed from 0x37df84ebe2e2f2cc to 0x37df84ebe2e2f55e [ 9636.361936] Lustre: MGC192.168.202.155@tcp: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 9640.326960] Lustre: lustre-MDT0000-mdc-ffff927f50e7e800: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 9643.082201] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9643.748563] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9645.894839] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9651.693787] Lustre: lustre-MDT0000-mdc-ffff927f50e7e800: Connection to lustre-MDT0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9661.942120] LustreError: MGC192.168.202.155@tcp: Connection to MGS (at 192.168.202.155@tcp) was lost; in progress operations using this service will fail [ 9661.952036] Lustre: Evicted from MGS (at 192.168.202.155@tcp) after server handle changed from 0x37df84ebe2e2f55e to 0x37df84ebe2e2f86e [ 9661.957866] Lustre: MGC192.168.202.155@tcp: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 9666.940660] Lustre: lustre-MDT0000-mdc-ffff927f50e7e800: Connection restored to 192.168.202.155@tcp (at 192.168.202.155@tcp) [ 9669.844353] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9670.595247] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9672.495610] Lustre: Unmounted lustre-client [ 9711.962058] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9714.359856] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9722.787688] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9728.505427] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 9728.908191] Lustre: Unmounted lustre-client [ 9748.178400] Key type lgssc unregistered [ 9748.323046] LNet: 225550:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9748.326211] LNetError: 225550:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9748.333583] LNet: Removed LNI 192.168.202.55@tcp [ 9748.724900] Key type .llcrypt unregistered [ 9748.726929] Key type ._llcrypt unregistered [ 9755.995067] Key type ._llcrypt registered [ 9755.996153] Key type .llcrypt registered [ 9756.502310] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 09:50:51 (1789307451) [ 9758.165466] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9758.172260] alg: No test for adler32 (adler32-zlib) [ 9759.046952] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 9759.137413] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 9760.727192] Key type lgssc registered [ 9761.159497] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9784.291675] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9787.056057] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9794.990701] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9801.706198] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 9808.609194] Lustre: Unmounted lustre-client [ 9843.840857] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9845.835381] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9852.476796] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9863.152059] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 9869.273505] Lustre: Unmounted lustre-client [ 9902.833573] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9904.729775] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9912.230734] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9922.556371] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [ 9922.864027] Lustre: Unmounted lustre-client [ 9936.077163] Key type lgssc unregistered [ 9936.188631] LNet: 232573:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9936.190902] LNetError: 232573:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9936.202442] LNet: Removed LNI 192.168.202.55@tcp [ 9936.450627] Key type .llcrypt unregistered [ 9936.452287] Key type ._llcrypt unregistered [ 9941.606884] Key type ._llcrypt registered [ 9941.607738] Key type .llcrypt registered [ 9942.033698] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 09:53:56 (1789307636) [ 9943.042188] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9943.048361] alg: No test for adler32 (adler32-zlib) [ 9943.895577] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 9943.976118] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 9945.559171] Key type lgssc registered [ 9945.931539] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9962.033860] Key type lgssc unregistered [ 9962.152414] LNet: 234882:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9962.155564] LNetError: 234882:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9962.168305] LNet: Removed LNI 192.168.202.55@tcp [ 9962.404621] Key type .llcrypt unregistered [ 9962.406245] Key type ._llcrypt unregistered [ 9971.938667] Key type ._llcrypt registered [ 9971.939844] Key type .llcrypt registered [ 9972.185057] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9972.191795] alg: No test for adler32 (adler32-zlib) [ 9973.044618] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [ 9973.138800] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [ 9974.727173] Key type lgssc registered [ 9975.163115] Lustre: Echo OBD driver; http://www.lustre.org/ [10004.519789] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10006.402789] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10014.520231] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10035.938688] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10036.492970] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 09:55:31 (1789307731) [10047.562284] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10049.448286] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10056.671805] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10065.559043] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10066.763226] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10072.036930] Lustre: lustre-OST0001-osc-ffff927f50e78000: Connection to lustre-OST0001 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [10074.590551] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10084.860466] Lustre: Unmounted lustre-client [10116.632798] Key type lgssc unregistered [10116.741746] LNet: 241963:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10116.744383] LNetError: 241963:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10116.751817] LNet: Removed LNI 192.168.202.55@tcp [10116.985349] Key type .llcrypt unregistered [10116.986648] Key type ._llcrypt unregistered [10127.579507] Key type ._llcrypt registered [10127.580930] Key type .llcrypt registered [10128.048499] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 09:57:02 (1789307822) [10132.857742] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10132.864519] alg: No test for adler32 (adler32-zlib) [10133.721680] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [10133.807899] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [10135.391172] Key type lgssc registered [10135.774730] Lustre: Echo OBD driver; http://www.lustre.org/ [10155.107057] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10157.225837] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10169.028892] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 09:57:43 (1789307863) [10180.910506] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10183.043205] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10190.363813] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10192.595164] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10199.557296] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [10205.684348] Lustre: Unmounted lustre-client [10256.818395] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10258.629720] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10293.663384] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10303.987336] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10304.439536] Lustre: Unmounted lustre-client [10321.974535] Key type lgssc unregistered [10322.082633] LNet: 249703:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10322.084845] LNetError: 249703:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10322.091697] LNet: Removed LNI 192.168.202.55@tcp [10322.349078] Key type .llcrypt unregistered [10322.350217] Key type ._llcrypt unregistered [10332.139112] Key type ._llcrypt registered [10332.142544] Key type .llcrypt registered [10332.434586] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10332.440733] alg: No test for adler32 (adler32-zlib) [10333.298163] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [10333.396349] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [10334.983119] Key type lgssc registered [10335.361586] Lustre: Echo OBD driver; http://www.lustre.org/ [10364.852175] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10366.891673] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10374.751373] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10395.686953] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [10396.273561] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 10:01:31 (1789308091) [10406.376976] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10408.163836] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10414.588499] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10425.842874] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10426.649827] Lustre: Unmounted lustre-client [10443.668655] Key type lgssc unregistered [10443.784395] LNet: 256320:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10443.786522] LNetError: 256320:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10443.799730] LNet: Removed LNI 192.168.202.55@tcp [10444.017464] Key type .llcrypt unregistered [10444.018705] Key type ._llcrypt unregistered [10448.983927] Key type ._llcrypt registered [10448.985118] Key type .llcrypt registered [10449.428266] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [10449.944333] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 10:02:24 (1789308144) [10452.856421] Key type .llcrypt unregistered [10452.857732] Key type ._llcrypt unregistered [10455.516774] Key type ._llcrypt registered [10455.520314] Key type .llcrypt registered [10455.733089] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10455.738154] alg: No test for adler32 (adler32-zlib) [10456.596708] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [10456.688376] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [10458.279181] Key type lgssc registered [10458.659655] Lustre: Echo OBD driver; http://www.lustre.org/ [10476.911887] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10486.259158] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10486.716120] Lustre: Unmounted lustre-client [10505.662818] Key type lgssc unregistered [10505.779547] LNet: 259756:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10505.781514] LNetError: 259756:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10505.788708] LNet: Removed LNI 192.168.202.55@tcp [10506.050697] Key type .llcrypt unregistered [10506.052132] Key type ._llcrypt unregistered [10512.163074] Key type ._llcrypt registered [10512.164120] Key type .llcrypt registered [10512.663703] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 10:03:27 (1789308207) [10513.460606] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10513.478973] alg: No test for adler32 (adler32-zlib) [10514.362724] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [10514.458973] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [10516.047283] Key type lgssc registered [10516.461436] Lustre: Echo OBD driver; http://www.lustre.org/ [10576.758399] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10587.259034] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10589.110688] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10590.267680] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10590.744967] Lustre: Unmounted lustre-client [10607.909621] Key type lgssc unregistered [10608.016595] LNet: 263279:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10608.019235] LNetError: 263279:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10608.029668] LNet: Removed LNI 192.168.202.55@tcp [10608.302642] Key type .llcrypt unregistered [10608.304033] Key type ._llcrypt unregistered [10612.972588] Key type ._llcrypt registered [10612.973867] Key type .llcrypt registered [10613.418237] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 10:05:08 (1789308308) [10614.155513] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10614.162383] alg: No test for adler32 (adler32-zlib) [10615.016396] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [10615.114582] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [10616.703175] Key type lgssc registered [10617.092484] Lustre: Echo OBD driver; http://www.lustre.org/ [10634.747490] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10636.520239] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10643.145765] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10653.683046] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10658.786406] Lustre: lustre-MDT0000-mdc-ffff927f4671c000: Connection to lustre-MDT0000 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [10661.248359] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10661.257058] LustreError: 266421:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [10661.356664] LustreError: MGC192.168.202.155@tcp: Connection to MGS (at 192.168.202.155@tcp) was lost; in progress operations using this service will fail [10661.382162] Lustre: Unmounted lustre-client [10672.145286] Key type lgssc unregistered [10672.258283] LNet: 266832:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10672.260251] LNetError: 266832:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10672.273374] LNet: Removed LNI 192.168.202.55@tcp [10672.539491] Key type .llcrypt unregistered [10672.540557] Key type ._llcrypt unregistered [10677.791774] Key type ._llcrypt registered [10677.792628] Key type .llcrypt registered [10678.226554] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 10:06:13 (1789308373) [10678.925555] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10678.952072] alg: No test for adler32 (adler32-zlib) [10679.811455] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [10679.896188] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [10681.479168] Key type lgssc registered [10681.868548] Lustre: Echo OBD driver; http://www.lustre.org/ [10698.581161] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10700.247825] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10706.702332] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10717.169234] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10722.274232] Lustre: lustre-MDT0001-mdc-ffff927f4775a800: Connection to lustre-MDT0001 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [10724.881230] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [10725.240704] Lustre: Unmounted lustre-client [10736.071124] Key type lgssc unregistered [10736.195568] LNet: 270396:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10736.197898] LNetError: 270396:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10736.205857] LNet: Removed LNI 192.168.202.55@tcp [10736.489149] Key type .llcrypt unregistered [10736.490325] Key type ._llcrypt unregistered [10742.010322] Key type ._llcrypt registered [10742.011856] Key type .llcrypt registered [10742.448617] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 10:07:17 (1789308437) [10748.135313] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10748.201123] alg: No test for adler32 (adler32-zlib) [10749.042267] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [10749.121659] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [10750.695182] Key type lgssc registered [10751.069825] Lustre: Echo OBD driver; http://www.lustre.org/ [10786.729759] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10787.890567] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10803.681972] Lustre: lustre-MDT0001-mdc-ffff927f4583f800: Connection to lustre-MDT0001 (at 192.168.202.155@tcp) was lost; in progress operations using this service will wait for recovery to complete [10808.528894] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10818.807034] Lustre: Unmounted lustre-client [10835.799677] Key type lgssc unregistered [10835.909566] LNet: 276157:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10835.912286] LNetError: 276157:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10835.918738] LNet: Removed LNI 192.168.202.55@tcp [10836.166949] Key type .llcrypt unregistered [10836.168094] Key type ._llcrypt unregistered [10841.436743] Key type ._llcrypt registered [10841.437711] Key type .llcrypt registered [10841.894253] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 10:08:56 (1789308536) [10842.445159] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [10843.031056] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 10:08:57 (1789308537) [10843.606550] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [10844.192963] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 10:08:59 (1789308539) [10844.760115] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [10845.342242] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 10:09:00 (1789308540) [10845.919949] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [10846.470533] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 10:09:01 (1789308541) [10846.996206] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [10847.555306] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 10:09:02 (1789308542) [10850.466402] Key type .llcrypt unregistered [10850.467468] Key type ._llcrypt unregistered [10852.813384] Key type ._llcrypt registered [10852.815114] Key type .llcrypt registered [10853.001886] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10853.010978] alg: No test for adler32 (adler32-zlib) [10853.864288] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [10853.955503] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [10855.543190] Key type lgssc registered [10855.946068] Lustre: Echo OBD driver; http://www.lustre.org/ [10883.215535] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10885.255147] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10893.196569] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10899.417881] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10899.825602] Lustre: Unmounted lustre-client [10922.819908] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 10:10:17 (1789308617) [10933.979348] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10935.946499] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10955.191842] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10975.728345] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [10976.078067] Lustre: Unmounted lustre-client [11001.746763] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 10:11:36 (1789308696) [11014.751307] LNet: 1 local NIs in recovery (showing 1): 192.168.202.55@tcp [11639.106952] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11649.821993] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11687.674495] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11787.390427] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 10:24:40 (1789309480) [11800.324457] Key type lgssc unregistered [11800.531207] LNet: 289648:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11800.536591] LNetError: 289648:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11801.574830] LNet: Removed LNI 192.168.202.55@tcp [11802.757197] Key type .llcrypt unregistered [11802.760566] Key type ._llcrypt unregistered [11940.354253] Key type ._llcrypt registered [11940.365946] Key type .llcrypt registered [11941.191358] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11941.231718] alg: No test for adler32 (adler32-zlib) [11942.709694] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [11943.027575] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [11944.706114] Key type lgssc registered [11946.070574] Lustre: Echo OBD driver; http://www.lustre.org/ [12057.511810] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12066.149637] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12097.052984] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12135.846282] Key type lgssc unregistered [12136.376688] LNet: 293359:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12136.387476] LNetError: 293359:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12136.408347] LNet: Removed LNI 192.168.202.55@tcp [12137.481681] Key type .llcrypt unregistered [12137.483072] Key type ._llcrypt unregistered [12176.951817] Key type ._llcrypt registered [12176.954832] Key type .llcrypt registered [12178.380032] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 10:31:12 (1789309872) [12204.458659] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12204.630992] alg: No test for adler32 (adler32-zlib) [12205.834726] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [12206.220230] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [12207.992458] Key type lgssc registered [12209.608953] Lustre: Echo OBD driver; http://www.lustre.org/ [12271.208885] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 10:32:44 (1789309964) [12285.997445] Key type lgssc unregistered [12286.333854] LNet: 296917:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12286.348824] LNetError: 296917:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12286.383621] LNet: Removed LNI 192.168.202.55@tcp [12287.029844] Key type .llcrypt unregistered [12287.035689] Key type ._llcrypt unregistered [12302.475940] Key type ._llcrypt registered [12302.481407] Key type .llcrypt registered [12303.094112] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12303.125237] alg: No test for adler32 (adler32-zlib) [12304.141261] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [12304.399305] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [12306.071328] Key type lgssc registered [12307.027365] Lustre: Echo OBD driver; http://www.lustre.org/ [12373.159570] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12380.650965] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12406.335296] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12710.727964] LNet: Added LNI 192.168.202.55@tcp50 [8/256/0/180] [12714.489684] LNet: Removed LNI 192.168.202.55@tcp [12717.139913] Lustre: 301333:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff927f60345800: config has no valid NIDs, force dynamic NIDs [12718.400235] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [12718.642152] Lustre: Unmounted lustre-client [12722.180673] Key type lgssc unregistered [12722.963732] LNet: 301592:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12722.972787] LNetError: 301592:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12724.027556] LNet: Removed LNI 192.168.202.55@tcp50 [12725.663422] Key type .llcrypt unregistered [12725.669729] Key type ._llcrypt unregistered [12748.294346] Key type ._llcrypt registered [12748.309216] Key type .llcrypt registered [12749.132985] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12749.176222] alg: No test for adler32 (adler32-zlib) [12750.414790] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [12750.820391] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [12752.663195] Key type lgssc registered [12754.022317] Lustre: Echo OBD driver; http://www.lustre.org/ [12816.219500] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12823.784660] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12833.309198] LNet: Added LNI 192.168.202.55@tcp50 [8/256/0/180] [12834.313401] LNet: Removed LNI 192.168.202.55@tcp [12835.507311] Lustre: 304280:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff927f60342800: config has no valid NIDs, force dynamic NIDs [12836.756437] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [12837.443367] Lustre: Unmounted lustre-client [12873.239665] Key type lgssc unregistered [12873.643472] LNet: 305147:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12873.655407] LNetError: 305147:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12873.677730] LNet: Removed LNI 192.168.202.55@tcp50 [12874.473609] Key type .llcrypt unregistered [12874.478079] Key type ._llcrypt unregistered [12889.591832] Key type ._llcrypt registered [12889.597026] Key type .llcrypt registered [12891.377486] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 10:43:04 (1789310584) [12916.102815] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12916.210788] alg: No test for adler32 (adler32-zlib) [12917.301581] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [12917.560330] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [12919.303229] Key type lgssc registered [12921.247330] Lustre: Echo OBD driver; http://www.lustre.org/ [13002.825579] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13009.362470] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13037.054679] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13070.667097] Key type lgssc unregistered [13071.007424] LNet: 309895:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13071.019493] LNetError: 309895:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13071.052632] LNet: Removed LNI 192.168.202.55@tcp [13071.951901] Key type .llcrypt unregistered [13071.955083] Key type ._llcrypt unregistered [13084.817457] Key type ._llcrypt registered [13084.820309] Key type .llcrypt registered [13086.224306] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 10:46:20 (1789310780) [13088.849571] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13088.937600] alg: No test for adler32 (adler32-zlib) [13090.270514] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [13090.734670] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [13092.535560] Key type lgssc registered [13093.726581] Lustre: Echo OBD driver; http://www.lustre.org/ [13149.628107] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13155.855580] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13176.912845] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13178.753577] Lustre: Mounted lustre-client - version 2.17.57_106_gd81f50d [13247.918204] Lustre: Mounted fs15246-client - version 2.17.57_106_gd81f50d [13266.687540] Lustre: Unmounted fs15246-client [13297.177586] Lustre: Unmounted lustre-client [13327.378557] Key type lgssc unregistered [13327.614909] LNet: 314758:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13327.626985] LNetError: 314758:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13327.650972] LNet: Removed LNI 192.168.202.55@tcp [13328.547427] Key type .llcrypt unregistered [13328.551778] Key type ._llcrypt unregistered [13342.426641] Key type ._llcrypt registered [13342.433447] Key type .llcrypt registered [13344.471989] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 10:50:37 (1789311037) [13346.343335] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13346.459603] alg: No test for adler32 (adler32-zlib) [13347.826534] Lustre: Lustre: Build Version: 2.17.57_106_gd81f50d [13348.145798] LNet: Added LNI 192.168.202.55@tcp [8/256/0/180] [13349.808765] Key type lgssc registered [13351.041959] Lustre: Echo OBD driver; http://www.lustre.org/ [13504.204823] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13510.528466] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13538.276462] Lustre: DEBUG MARKER: oleg255-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13669.999864] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 13418 sec ========= 10:56:03 (1789311363) [13671.875549] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 10:56:05 (1789311365) === [13675.934750] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 10:56:09 (1789311369) === [13714.615518] Key type lgssc unregistered [13714.938727] LNet: 324031:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13714.945446] LNetError: 324031:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13714.962423] LNet: Removed LNI 192.168.202.55@tcp [13715.656907] Key type .llcrypt unregistered [13715.659362] Key type ._llcrypt unregistered