[ 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 422908835 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001011] APIC: Switch to symmetric I/O mode setup [ 0.002369] x2apic enabled [ 0.003009] Switched APIC routing to physical x2apic. [ 0.004014] kvm-guest: setup PV IPIs [ 0.007396] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008022] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009015] pid_max: default: 32768 minimum: 301 [ 0.011061] LSM: Security Framework initializing [ 0.012055] Yama: becoming mindful. [ 0.013037] SELinux: Initializing. [ 0.014080] *** VALIDATE selinux *** [ 0.022590] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026780] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028027] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029111] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030108] *** VALIDATE tmpfs *** [ 0.031483] *** VALIDATE proc *** [ 0.033136] *** VALIDATE cgroup *** [ 0.034000] *** VALIDATE cgroup2 *** [ 0.034253] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035163] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036009] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037028] Spectre V2 : User space: Vulnerable [ 0.038010] Speculative Store Bypass: Vulnerable [ 0.041384] debug: unmapping init [mem 0xffffffffab859000-0xffffffffab860fff] [ 0.044175] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.045693] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.046023] ... version: 2 [ 0.047012] ... bit width: 48 [ 0.048011] ... generic registers: 4 [ 0.049012] ... value mask: 0000ffffffffffff [ 0.050014] ... max period: 00007fffffffffff [ 0.051016] ... fixed-purpose events: 3 [ 0.052013] ... event mask: 000000070000000f [ 0.054229] rcu: Hierarchical SRCU implementation. [ 0.056481] smp: Bringing up secondary CPUs ... [ 0.057572] x86: Booting SMP configuration: [ 0.058026] .... node #0, CPUs: #1 #2 #3 [ 0.065070] smp: Brought up 1 node, 4 CPUs [ 0.067016] smpboot: Max logical packages: 1 [ 0.068015] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.196032] node 0 deferred pages initialised in 126ms [ 0.199014] devtmpfs: initialized [ 0.200245] x86/mm: Memory block size: 128MB [ 0.202672] gcov: version magic: 0x41383552 [ 0.204461] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.207110] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.209408] pinctrl core: initialized pinctrl subsystem [ 0.211217] [ 0.211674] ************************************************************* [ 0.214019] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.216019] ** ** [ 0.219022] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.221017] ** ** [ 0.224021] ** This means that this kernel is built to expose internal ** [ 0.226020] ** IOMMU data structures, which may compromise security on ** [ 0.228021] ** your system. ** [ 0.230017] ** ** [ 0.233020] ** If you see this message and you are not debugging the ** [ 0.235018] ** kernel, report this immediately to your vendor! ** [ 0.237020] ** ** [ 0.239019] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.242023] ************************************************************* [ 0.244662] NET: Registered protocol family 16 [ 0.246428] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.249105] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.252095] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.256016] cpuidle: using governor menu [ 0.257763] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.258568] PCI: Using configuration type 1 for base access [ 0.259126] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.267063] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.269047] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.273071] cryptd: max_cpu_qlen set to 1000 [ 0.275234] ACPI: Added _OSI(Module Device) [ 0.277018] ACPI: Added _OSI(Processor Device) [ 0.279014] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.280013] ACPI: Added _OSI(Processor Aggregator Device) [ 0.285465] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.292446] ACPI: Interpreter enabled [ 0.293048] ACPI: PM: (supports S0 S3 S4 S5) [ 0.295011] ACPI: Using IOAPIC for interrupt routing [ 0.296132] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.299420] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.309677] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.312041] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.314021] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.317091] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.323312] acpiphp: Slot [2] registered [ 0.324161] acpiphp: Slot [5] registered [ 0.326194] acpiphp: Slot [6] registered [ 0.327163] acpiphp: Slot [3] registered [ 0.328072] acpiphp: Slot [4] registered [ 0.329061] acpiphp: Slot [7] registered [ 0.331095] acpiphp: Slot [8] registered [ 0.332096] acpiphp: Slot [9] registered [ 0.334148] acpiphp: Slot [10] registered [ 0.335058] acpiphp: Slot [11] registered [ 0.336093] acpiphp: Slot [12] registered [ 0.338101] acpiphp: Slot [13] registered [ 0.339148] acpiphp: Slot [14] registered [ 0.341114] acpiphp: Slot [15] registered [ 0.342130] acpiphp: Slot [16] registered [ 0.344125] acpiphp: Slot [17] registered [ 0.346117] acpiphp: Slot [18] registered [ 0.348128] acpiphp: Slot [19] registered [ 0.349167] acpiphp: Slot [20] registered [ 0.351135] acpiphp: Slot [21] registered [ 0.353131] acpiphp: Slot [22] registered [ 0.355185] acpiphp: Slot [23] registered [ 0.357137] acpiphp: Slot [24] registered [ 0.359258] acpiphp: Slot [25] registered [ 0.361106] acpiphp: Slot [26] registered [ 0.363144] acpiphp: Slot [27] registered [ 0.365166] acpiphp: Slot [28] registered [ 0.366124] acpiphp: Slot [29] registered [ 0.368105] acpiphp: Slot [30] registered [ 0.370132] acpiphp: Slot [31] registered [ 0.372095] PCI host bridge to bus 0000:00 [ 0.374022] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.377039] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.380035] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.382051] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.386042] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.390043] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.393267] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.396035] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.400374] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.408023] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.413014] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.416030] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.418028] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.421030] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.424380] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.427778] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.430046] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.433900] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.437956] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.448782] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.453017] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.460924] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.469025] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.479028] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.498026] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.505840] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.511015] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.517015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.528018] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.538185] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.540374] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.542315] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.544610] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.547207] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.551104] iommu: Default domain type: Passthrough [ 0.552516] SCSI subsystem initialized [ 0.554203] ACPI: bus type USB registered [ 0.556173] usbcore: registered new interface driver usbfs [ 0.558117] usbcore: registered new interface driver hub [ 0.560122] usbcore: registered new device driver usb [ 0.562253] pps_core: LinuxPPS API ver. 1 registered [ 0.564017] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.567107] PTP clock support registered [ 0.569178] EDAC MC: Ver: 3.0.0 [ 0.571164] PCI: Using ACPI for IRQ routing [ 0.573870] NetLabel: Initializing [ 0.575018] NetLabel: domain hash size = 128 [ 0.577014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.578102] NetLabel: unlabeled traffic allowed by default [ 0.580216] vgaarb: loaded [ 0.582320] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.584015] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.589247] clocksource: Switched to clocksource kvm-clock [ 0.702441] VFS: Disk quotas dquot_6.6.0 [ 0.704103] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.706638] *** VALIDATE ramfs *** [ 0.707905] *** VALIDATE hugetlbfs *** [ 0.709563] pnp: PnP ACPI init [ 0.711897] pnp: PnP ACPI: found 6 devices [ 0.738816] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.742507] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.744854] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.747129] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.749718] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.752187] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.755076] NET: Registered protocol family 2 [ 0.757521] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.762166] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.765930] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.771646] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.774631] TCP: Hash tables configured (established 65536 bind 65536) [ 0.777493] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.780579] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.783401] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.786366] NET: Registered protocol family 1 [ 0.788725] RPC: Registered named UNIX socket transport module. [ 0.791222] RPC: Registered udp transport module. [ 0.792985] RPC: Registered tcp transport module. [ 0.794318] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.796508] NET: Registered protocol family 44 [ 0.798417] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.800545] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.802702] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.804956] PCI: CLS 0 bytes, default 64 [ 0.806283] Unpacking initramfs... [ 2.219877] debug: unmapping init [mem 0xffff8977bcc64000-0xffff8977bffcffff] [ 2.225030] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.228407] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.232667] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.743264] Initialise system trusted keyrings [ 2.745273] Key type blacklist registered [ 2.748698] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.758413] zbud: loaded [ 2.761601] *** VALIDATE nfs *** [ 2.763306] *** VALIDATE nfs4 *** [ 2.765158] pstore: using deflate compression [ 2.769424] Platform Keyring initialized [ 2.873926] NET: Registered protocol family 38 [ 2.875791] Key type asymmetric registered [ 2.877359] Asymmetric key parser 'x509' registered [ 2.878885] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.881477] io scheduler mq-deadline registered [ 2.883967] io scheduler kyber registered [ 2.886330] io scheduler bfq registered [ 2.888894] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.892814] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.896867] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.900953] ACPI: Power Button [PWRF] [ 2.906919] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.914862] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.929781] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.958331] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.987132] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.992550] Non-volatile memory driver v1.3 [ 2.994309] Linux agpgart interface v0.103 [ 3.027545] virtio_blk virtio1: [vda] 145920 512-byte logical blocks (74.7 MB/71.3 MiB) [ 3.031871] vda: detected capacity change from 0 to 74711040 [ 3.046478] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.050384] vdb: detected capacity change from 0 to 1073741824 [ 3.056401] libphy: Fixed MDIO Bus: probed [ 3.063397] usbcore: registered new interface driver usbserial_generic [ 3.066128] usbserial: USB Serial support registered for generic [ 3.068500] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.073431] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.075621] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.078406] mousedev: PS/2 mouse device common for all mice [ 3.081306] rtc_cmos 00:05: RTC can wake from S4 [ 3.084741] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.084778] rtc_cmos 00:05: registered as rtc0 [ 3.091327] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.091729] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.095444] intel_pstate: CPU model not supported [ 3.099093] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.104460] hid: raw HID events driver (C) Jiri Kosina [ 3.107471] usbcore: registered new interface driver usbhid [ 3.110335] usbhid: USB HID core driver [ 3.112531] drop_monitor: Initializing network drop monitor service [ 3.115848] Initializing XFRM netlink socket [ 3.118745] NET: Registered protocol family 10 [ 3.121900] Segment Routing with IPv6 [ 3.123381] NET: Registered protocol family 17 [ 3.125908] mpls_gso: MPLS GSO support [ 3.132574] RAS: Correctable Errors collector initialized. [ 3.135272] AVX version of gcm_enc/dec engaged. [ 3.137391] AES CTR mode by8 optimization enabled [ 3.213374] sched_clock: Marking stable (3213344469, 0)->(4087488522, -874144053) [ 3.216192] registered taskstats version 1 [ 3.217843] Loading compiled-in X.509 certificates [ 3.219951] zswap: loaded using pool lzo/zbud [ 3.246305] Key type big_key registered [ 3.260663] Key type encrypted registered [ 3.262186] ima: No TPM chip found, activating TPM-bypass! [ 3.263691] ima: Allocated hash algorithm: sha1 [ 3.265026] ima: No architecture policies found [ 3.266312] evm: Initialising EVM extended attributes: [ 3.267609] evm: security.selinux [ 3.268542] evm: security.ima [ 3.269467] evm: security.capability [ 3.270595] evm: HMAC attrs: 0x1 [ 3.273073] rtc_cmos 00:05: setting system clock to 2026-08-14 22:23:25 UTC (1786746205) [ 3.278977] debug: unmapping init [mem 0xffffffffac803000-0xffffffffac9fffff] [ 3.281270] debug: unmapping init [mem 0xffffffffab582000-0xffffffffab858fff] [ 3.289079] Write protecting the kernel read-only data: 28672k [ 3.291887] debug: unmapping init [mem 0xffffffffa9c03000-0xffffffffa9dfffff] [ 3.294480] debug: unmapping init [mem 0xffffffffaa514000-0xffffffffaa5fffff] [ 3.325713] 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.332130] systemd[1]: Detected virtualization kvm. [ 3.333591] systemd[1]: Detected architecture x86-64. [ 3.335329] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.361046] systemd[1]: No hostname configured. [ 3.362543] systemd[1]: Set hostname to . [ 3.364503] random: systemd: uninitialized urandom read (16 bytes read) [ 3.366681] systemd[1]: Initializing machine ID from random generator. [ 3.419558] random: ln: uninitialized urandom read (6 bytes read) [ 3.515191] random: systemd: uninitialized urandom read (16 bytes read) [ 3.519152] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.526404] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.531820] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Swap. [ OK ] Reached target Local File Systems. [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Sockets. [ OK ] Started Memstrack Anylazing Service. Starting Apply Kernel Variables... Starting Journal Service... Starting Create Volatile Files and Directories... Starting Setup Virtual Console... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Setup Virtual Console. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.197438] device-mapper: uevent: version 1.0.3 [ 4.199583] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 5.181246] virtio_net virtio0 ens2: renamed from eth0 [ 5.470653] scsi host0: ata_piix [ 5.543582] scsi host1: ata_piix [ 5.547501] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.552466] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.778766] random: crng init done [ 9.782343] random: 7 urandom warning(s) missed due to ratelimiting [ 12.082837] dracut-initqueue[593]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 13.828579] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Timers. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ 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... [ 15.995399] hrtimer: interrupt took 2996631 ns [ 16.358331] printk: systemd: 26 output lines suppressed due to ratelimiting [ 16.977742] SELinux: Disabled at runtime. [ 17.178583] 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) [ 17.194478] systemd[1]: Detected virtualization kvm. [ 17.201082] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 19.011854] systemd[1]: initrd-switch-root.service: Succeeded. [ 19.026608] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 19.046096] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 19.055774] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 19.069143] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 19.095427] systemd[1]: Starting Journal Service... Starting Journal Service... [ 19.137425] systemd[1]: Created slice User and Session Slice. [ OK ] Created slice User and Session Slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Listening on udev Control Socket. Mounting Huge Pages File System... [ OK ] Stopped target Switch Root. Activating swap /dev/disk/by-label/SWAP... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Create list of required st…ce nodes for the current kernel... [ 19.347694] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Stopped target Initrd Root File System. [ OK ] Created slice system-sshd\x2dkeygen.slice. Starting Remount Root and Kernel File Systems... [ OK ] Stopped target Initrd File Systems. Mounting POSIX Message Queue File System... [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Reached target Slices. Mounting Kernel Debug File System... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Created slice system-getty.slice. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target rpc_pipefs.target. Starting Apply Kernel Variables... [ OK ] Started Journal Service. [ OK ] Mounted Huge Pages File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Apply Kernel Variables. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 20.933433] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 21.973767] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 22.057147] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 22.933300] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 23.074241] EDAC sbridge: Ver: 1.1.2 [* ] A start job is running for Configur…-only root support (7s / no limit)[ 27.015241] Key type dns_resolver registered [** ] A start job is running for Configur…-only root support (8s / no limit) [*** ] A start job is running for Configur…-only root support (9s / no limit)[ 27.955568] NFS: Registering the id_resolver key type [ 27.962314] Key type id_resolver registered [ 27.969413] Key type id_legacy registered [ *** ] A start job is running for Configur…-only root support (9s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... Starting Mark the need to relabel after reboot... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started Login Service. [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg237-client login: [ 102.233508] libcfs: loading out-of-tree module taints kernel. [ 102.451608] Key type ._llcrypt registered [ 102.460497] Key type .llcrypt registered [ 102.919142] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 102.930739] alg: No test for adler32 (adler32-zlib) [ 104.319926] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 104.969259] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 106.712351] Key type lgssc registered [ 109.191235] Lustre: Echo OBD driver; http://www.lustre.org/ [ 288.199662] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 293.358841] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 310.516653] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing check_logdir /tmp/testlogs/ [ 313.837837] Lustre: lustre-OST0000-osc-ffff897807982000: disconnect after 23s idle [ 316.655349] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing yml_node [ 322.136905] Lustre: DEBUG MARKER: Client: 2.17.57.3 [ 325.511710] Lustre: DEBUG MARKER: MDS: 2.17.57.3 [ 329.110454] Lustre: DEBUG MARKER: OSS: 2.17.57.3 [ 331.485992] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Aug 14 18:28:51 EDT 2026 [ 353.766613] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 355.415909] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 359.477866] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 369.869238] Lustre: Unmounted lustre-client [ 487.521956] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 492.742907] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 516.347214] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 556.255924] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 18:32:37 (1786746757) [ 558.886991] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 560.539171] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 18:32:41 (1786746761) [ 605.296685] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 612.679550] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 636.903959] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 637.505499] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 641.402198] Lustre: Unmounted lustre-client [ 671.137985] Key type lgssc unregistered [ 671.344368] LNet: 15057:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 671.360571] LNetError: 15057:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 671.391717] LNet: Removed LNI 192.168.202.37@tcp [ 672.219303] Key type .llcrypt unregistered [ 672.221220] Key type ._llcrypt unregistered [ 690.246426] Key type ._llcrypt registered [ 690.249562] Key type .llcrypt registered [ 691.274416] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 18:34:52 (1786746892) [ 693.302674] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 693.446398] alg: No test for adler32 (adler32-zlib) [ 694.647977] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 694.794417] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 696.408847] Key type lgssc registered [ 697.418977] Lustre: Echo OBD driver; http://www.lustre.org/ [ 780.094538] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 871.723548] Lustre: Unmounted lustre-client [ 909.934551] Key type lgssc unregistered [ 910.239855] LNet: 18917:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 910.247950] LNetError: 18917:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 910.291843] LNet: Removed LNI 192.168.202.37@tcp [ 911.304366] Key type .llcrypt unregistered [ 911.308460] Key type ._llcrypt unregistered [ 925.464768] Key type ._llcrypt registered [ 925.466971] Key type .llcrypt registered [ 927.581684] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 18:38:47 (1786747127) [ 931.666511] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 931.673420] alg: No test for adler32 (adler32-zlib) [ 932.848210] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 933.424691] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 935.104419] Key type lgssc registered [ 937.637550] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1000.846348] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1008.071228] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1036.020363] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1042.014544] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 1054.340469] Lustre: Unmounted lustre-client [ 1085.318266] Key type lgssc unregistered [ 1085.712669] LNet: 22528:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1085.723631] LNetError: 22528:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1085.740630] LNet: Removed LNI 192.168.202.37@tcp [ 1087.017499] Key type .llcrypt unregistered [ 1087.020792] Key type ._llcrypt unregistered [ 1099.099824] Key type ._llcrypt registered [ 1099.101959] Key type .llcrypt registered [ 1100.395152] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 18:41:41 (1786747301) [ 1103.036980] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1103.078957] alg: No test for adler32 (adler32-zlib) [ 1104.171297] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 1104.386367] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 1106.064464] Key type lgssc registered [ 1107.298736] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1167.939913] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1175.685280] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1202.582774] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1208.421916] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 1215.520526] Lustre: Unmounted lustre-client [ 1246.536879] Key type lgssc unregistered [ 1246.836213] LNet: 25738:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1246.846538] LNetError: 25738:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1246.878531] LNet: Removed LNI 192.168.202.37@tcp [ 1247.870591] Key type .llcrypt unregistered [ 1247.872242] Key type ._llcrypt unregistered [ 1268.614509] Key type ._llcrypt registered [ 1268.623345] Key type .llcrypt registered [ 1271.189212] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 18:44:30 (1786747470) [ 1274.384670] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1274.402329] alg: No test for adler32 (adler32-zlib) [ 1275.557484] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 1275.886864] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 1277.544219] Key type lgssc registered [ 1278.791558] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1335.863950] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1342.475779] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1367.899225] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1379.854181] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 1384.952292] Lustre: lustre-MDT0000-mdc-ffff8978119b2000: Connection to lustre-MDT0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1395.176288] Lustre: lustre-MDT0001-mdc-ffff8978119b2000: Connection to lustre-MDT0001 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1399.997332] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1406.432862] Lustre: 26697:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786747592/real 1786747592] req@000000000a16c224 x1873540523497600/t0(0) o400->MGC192.168.202.137@tcp@192.168.202.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1786747608 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1406.469582] LustreError: MGC192.168.202.137@tcp: Connection to MGS (at 192.168.202.137@tcp) was lost; in progress operations using this service will fail [ 1410.366519] Lustre: Unmounted lustre-client [ 1432.229524] Key type lgssc unregistered [ 1432.457954] LNet: 29399:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1432.463553] LNetError: 29399:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1432.494355] LNet: Removed LNI 192.168.202.37@tcp [ 1433.344794] Key type .llcrypt unregistered [ 1433.347862] Key type ._llcrypt unregistered [ 1451.883668] Key type ._llcrypt registered [ 1451.885128] Key type .llcrypt registered [ 1453.751637] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 18:47:33 (1786747653) [ 1456.597674] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1456.691518] alg: No test for adler32 (adler32-zlib) [ 1457.878909] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 1458.128428] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 1459.896400] Key type lgssc registered [ 1461.501198] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1516.790392] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1523.815819] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1552.253618] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1554.033941] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 1559.031700] Lustre: lustre-OST0000-osc-ffff897805319800: Connection to lustre-OST0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1566.996198] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1577.300530] Lustre: Unmounted lustre-client [ 1615.423667] Key type lgssc unregistered [ 1615.738632] LNet: 33013:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1615.744981] LNetError: 33013:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1615.769533] LNet: Removed LNI 192.168.202.37@tcp [ 1616.582645] Key type .llcrypt unregistered [ 1616.589587] Key type ._llcrypt unregistered [ 1635.174309] Key type ._llcrypt registered [ 1635.176537] Key type .llcrypt registered [ 1636.845240] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 18:50:37 (1786747837) [ 1639.831932] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1639.906363] alg: No test for adler32 (adler32-zlib) [ 1641.045063] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 1641.333677] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 1643.072238] Key type lgssc registered [ 1644.037602] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1696.885943] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1702.981144] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1724.683905] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1727.432902] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 1734.197688] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1737.729618] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1749.267367] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-1418h52m30s [ 1751.418175] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1758.180891] Lustre: lustre-MDT0000-mdc-ffff897803040000: Connection to lustre-MDT0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1761.620041] LustreError: 36801:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff897803040000: can't stat MDS #0: rc = -19 [ 1763.348684] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1770.476173] LustreError: MGC192.168.202.137@tcp: Connection to MGS (at 192.168.202.137@tcp) was lost; in progress operations using this service will fail [ 1770.502702] Lustre: Evicted from MGS (at 192.168.202.137@tcp) after server handle changed from 0x17089b4aebc33708 to 0x17089b4aebc339b6 [ 1770.526996] Lustre: MGC192.168.202.137@tcp: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [ 1771.591866] LustreError: lustre-MDT0000-mdc-ffff897803040000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1771.627395] Lustre: lustre-MDT0000-mdc-ffff897803040000: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [ 1778.702281] Lustre: DEBUG MARKER: Wait for df (36801) ... [ 1780.914811] Lustre: DEBUG MARKER: done [ 1783.720590] Lustre: Unmounted lustre-client [ 1819.414386] Key type lgssc unregistered [ 1819.676178] LNet: 37822:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1819.687221] LNetError: 37822:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1819.714663] LNet: Removed LNI 192.168.202.37@tcp [ 1820.428884] Key type .llcrypt unregistered [ 1820.431565] Key type ._llcrypt unregistered [ 1852.694531] Key type ._llcrypt registered [ 1852.697830] Key type .llcrypt registered [ 1854.136566] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 18:54:14 (1786748054) [ 1857.116418] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1857.133636] alg: No test for adler32 (adler32-zlib) [ 1858.273791] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 1858.539427] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 1860.296630] Key type lgssc registered [ 1861.652101] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1922.569966] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1929.367567] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1950.853679] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1952.551185] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 1957.948051] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-1418h55m58s [ 1959.636187] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1966.835419] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1969.143784] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1989.608110] Lustre: 41965:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786748171/real 1786748171] req@00000000f94e2f99 x1873541133769344/t0(0) o101->lustre-MDT0000-mdc-ffff897818638800@192.168.202.137@tcp:12/10 lens 576/1152 e 0 to 1 dl 1786748191 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1989.654334] Lustre: lustre-MDT0000-mdc-ffff897818638800: Connection to lustre-MDT0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1989.728229] Lustre: lustre-MDT0000-mdc-ffff897818638800: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [ 2011.046453] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 2014.645702] Lustre: DEBUG MARKER: done [ 2018.977560] Lustre: Unmounted lustre-client [ 2056.892869] Key type lgssc unregistered [ 2057.201766] LNet: 42856:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2057.211978] LNetError: 42856:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2057.234336] LNet: Removed LNI 192.168.202.37@tcp [ 2057.971170] Key type .llcrypt unregistered [ 2057.975732] Key type ._llcrypt unregistered [ 2094.176536] Key type ._llcrypt registered [ 2094.178722] Key type .llcrypt registered [ 2095.559786] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 18:58:16 (1786748296) [ 2097.026384] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2099.047412] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 18:58:19 (1786748299) [ 2103.794425] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2103.845056] alg: No test for adler32 (adler32-zlib) [ 2104.988731] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 2105.280526] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 2106.992215] Key type lgssc registered [ 2108.878470] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2140.831857] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 18:59:01 (1786748341) [ 2178.830726] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2185.307968] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2209.689777] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2212.553406] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 2216.650538] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2221.195650] Lustre: Unmounted lustre-client [ 2239.478543] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2287.512978] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2295.682037] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2296.396763] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 2300.342975] Lustre: Unmounted lustre-client [ 2357.304349] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2362.770471] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2363.429369] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 2367.985278] Lustre: Unmounted lustre-client [ 2391.461433] Lustre: DEBUG MARKER: files compared the same [ 2405.959418] Key type lgssc unregistered [ 2406.265792] LNet: 50488:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2406.288908] LNetError: 50488:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2406.313182] LNet: Removed LNI 192.168.202.37@tcp [ 2407.280357] Key type .llcrypt unregistered [ 2407.282700] Key type ._llcrypt unregistered [ 2423.639897] Key type ._llcrypt registered [ 2423.642530] Key type .llcrypt registered [ 2425.178234] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 19:03:45 (1786748625) [ 2427.815879] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2427.866121] alg: No test for adler32 (adler32-zlib) [ 2429.288537] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 2429.699723] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 2431.489104] Key type lgssc registered [ 2433.298459] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2484.481823] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2491.832520] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2518.830561] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2520.819252] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 2523.857527] Lustre: Unmounted lustre-client [ 2551.914082] Key type lgssc unregistered [ 2552.102795] LNet: 54075:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2552.108237] LNetError: 54075:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2552.124652] LNet: Removed LNI 192.168.202.37@tcp [ 2552.907993] Key type .llcrypt unregistered [ 2552.911735] Key type ._llcrypt unregistered [ 2570.103838] Key type ._llcrypt registered [ 2570.108801] Key type .llcrypt registered [ 2571.472742] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 19:06:12 (1786748772) [ 2573.800201] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2573.840975] alg: No test for adler32 (adler32-zlib) [ 2574.910510] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 2575.160453] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 2576.936247] Key type lgssc registered [ 2578.259155] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2665.229787] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2699.560821] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2707.147448] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2737.025684] Key type lgssc unregistered [ 2737.338244] LNet: 57570:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2737.344503] LNetError: 57570:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2737.360599] LNet: Removed LNI 192.168.202.37@tcp [ 2738.193419] Key type .llcrypt unregistered [ 2738.195596] Key type ._llcrypt unregistered [ 2754.328318] Key type ._llcrypt registered [ 2754.330440] Key type .llcrypt registered [ 2755.594316] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 19:09:16 (1786748956) [ 2759.124405] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2759.156093] alg: No test for adler32 (adler32-zlib) [ 2760.278530] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 2760.604056] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 2762.280331] Key type lgssc registered [ 2763.800429] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2852.540819] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 2860.495599] Lustre: Unmounted lustre-client [ 2898.295640] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 19:11:39 (1786749099) [ 3035.510581] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3058.275695] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 3064.199481] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3064.205250] LustreError: 64056:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8978064ea800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3064.221742] Lustre: 58554:0:(llite_lib.c:4340:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.137@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3074.552603] Lustre: Unmounted lustre-client [ 3121.198575] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 19:15:22 (1786749322) [ 3136.640206] Key type lgssc unregistered [ 3136.949820] LNet: 65273:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3136.956908] LNetError: 65273:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3136.985473] LNet: Removed LNI 192.168.202.37@tcp [ 3138.198212] Key type .llcrypt unregistered [ 3138.223502] Key type ._llcrypt unregistered [ 3151.618522] Key type ._llcrypt registered [ 3151.624550] Key type .llcrypt registered [ 3151.827727] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3151.855794] alg: No test for adler32 (adler32-zlib) [ 3152.918548] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 3153.125664] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 3154.865059] Key type lgssc registered [ 3156.025209] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3210.457888] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3216.952948] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3240.394700] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3243.026238] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 3246.477209] Lustre: Unmounted lustre-client [ 3275.955724] Key type lgssc unregistered [ 3276.298281] LNet: 68292:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3276.301574] LNetError: 68292:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3276.320637] LNet: Removed LNI 192.168.202.37@tcp [ 3276.940735] Key type .llcrypt unregistered [ 3276.948060] Key type ._llcrypt unregistered [ 3289.300251] Key type ._llcrypt registered [ 3289.302610] Key type .llcrypt registered [ 3289.650299] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3289.660974] alg: No test for adler32 (adler32-zlib) [ 3290.735215] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 3290.923491] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 3292.560253] Key type lgssc registered [ 3293.548863] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3405.056757] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3411.366683] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3433.544213] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3436.451337] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 3443.613763] Lustre: Unmounted lustre-client [ 3473.787708] Key type lgssc unregistered [ 3474.122777] LNet: 71723:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3474.137538] LNetError: 71723:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3475.174071] LNet: Removed LNI 192.168.202.37@tcp [ 3476.147496] Key type .llcrypt unregistered [ 3476.149244] Key type ._llcrypt unregistered [ 3498.367731] Key type ._llcrypt registered [ 3498.369853] Key type .llcrypt registered [ 3499.555763] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 19:21:40 (1786749700) [ 3503.358523] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3503.495259] alg: No test for adler32 (adler32-zlib) [ 3504.739730] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 3505.108695] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 3506.920405] Key type lgssc registered [ 3507.723873] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3558.912130] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3565.133826] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3588.600214] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3591.471155] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 3597.897026] Lustre: Unmounted lustre-client [ 3598.714273] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 3602.864054] Lustre: Unmounted lustre-client [ 3632.172456] Key type lgssc unregistered [ 3632.454952] LNet: 75412:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3632.463246] LNetError: 75412:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3633.524948] LNet: Removed LNI 192.168.202.37@tcp [ 3634.241481] Key type .llcrypt unregistered [ 3634.243187] Key type ._llcrypt unregistered [ 3647.495453] Key type ._llcrypt registered [ 3647.501802] Key type .llcrypt registered [ 3648.120813] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3648.132503] alg: No test for adler32 (adler32-zlib) [ 3649.375507] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 3649.900397] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 3651.624194] Key type lgssc registered [ 3652.691415] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3708.449546] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3718.012747] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3745.576937] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3752.515296] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 3758.032933] Lustre: Unmounted lustre-client [ 3791.900650] Key type lgssc unregistered [ 3792.174518] LNet: 78452:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3792.182883] LNetError: 78452:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3792.212734] LNet: Removed LNI 192.168.202.37@tcp [ 3793.025260] Key type .llcrypt unregistered [ 3793.027336] Key type ._llcrypt unregistered [ 3811.340149] Key type ._llcrypt registered [ 3811.346992] Key type .llcrypt registered [ 3812.879716] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 19:26:53 (1786750013) [ 3815.702470] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3815.764838] alg: No test for adler32 (adler32-zlib) [ 3816.884149] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 3817.140805] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 3818.825248] Key type lgssc registered [ 3820.160030] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3880.447487] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3888.255516] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3913.844608] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3919.983075] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 3926.336249] Lustre: lustre: root_squash is set to 0:0 [ 3932.068522] Lustre: lustre: nosquash_nids is cleared [ 3940.451231] Lustre: lustre: root_squash is set to 500:500 [ 3948.087597] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.37@tcp 192.168.0.[2,10]@tcp [ 3956.106859] Lustre: lustre: nosquash_nids set to 192.168.202.37/24@tcp [ 3959.715780] Lustre: Unmounted lustre-client [ 3985.191460] Key type lgssc unregistered [ 3985.488116] LNet: 82413:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3985.498621] LNetError: 82413:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3985.532548] LNet: Removed LNI 192.168.202.37@tcp [ 3986.686141] Key type .llcrypt unregistered [ 3986.688141] Key type ._llcrypt unregistered [ 4003.946980] Key type ._llcrypt registered [ 4003.950117] Key type .llcrypt registered [ 4005.211801] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 19:30:06 (1786750206) [ 4007.836721] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 4009.886817] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 19:30:10 (1786750210) [ 4013.326966] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4013.369342] alg: No test for adler32 (adler32-zlib) [ 4014.759062] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 4015.208098] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 4017.234592] Key type lgssc registered [ 4020.227528] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4087.663224] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4095.493334] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4119.169352] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4120.952892] Lustre: lustre: root_squash is set to 500:500 [ 4120.976673] Lustre: lustre: nosquash_nids set to 192.168.202.37/24@tcp [ 4126.300309] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 4132.301647] Lustre: Unmounted lustre-client [ 4157.174646] Key type lgssc unregistered [ 4157.447418] LNet: 86382:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4157.452277] LNetError: 86382:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4157.464708] LNet: Removed LNI 192.168.202.37@tcp [ 4157.995601] Key type .llcrypt unregistered [ 4157.998697] Key type ._llcrypt unregistered [ 4175.977537] Key type ._llcrypt registered [ 4175.979442] Key type .llcrypt registered [ 4177.562819] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4179.573347] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 19:33:00 (1786750380) [ 4199.875125] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4199.911564] alg: No test for adler32 (adler32-zlib) [ 4201.021117] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 4201.282471] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 4202.920222] Key type lgssc registered [ 4203.975679] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4296.837665] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4303.698564] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4330.783202] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4407.275944] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4412.919635] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4436.066698] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4447.995047] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 4484.897961] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff897809b41800.ost_server_uuid 50 [ 4486.806773] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff897809b41800.ost_server_uuid in IDLE state after 0 sec [ 4487.401917] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 4491.085370] Lustre: Unmounted lustre-client [ 4493.910387] Lustre: Unmounted lustre-client [ 4552.030537] Key type lgssc unregistered [ 4552.267289] LNet: 94068:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4552.275482] LNetError: 94068:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4552.287522] LNet: Removed LNI 192.168.202.37@tcp [ 4552.881099] Key type .llcrypt unregistered [ 4552.883108] Key type ._llcrypt unregistered [ 4584.686330] Key type ._llcrypt registered [ 4584.688082] Key type .llcrypt registered [ 4585.841192] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 19:39:46 (1786750786) [ 4608.843520] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4609.026859] alg: No test for adler32 (adler32-zlib) [ 4610.220735] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 4610.451041] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 4612.112239] Key type lgssc registered [ 4613.974576] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4705.773502] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4711.492814] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4734.241746] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4737.088639] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 4758.498680] Lustre: 95432:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786750944/real 1786750944] req@00000000ea433f40 x1873544019449088/t0(0) o400->lustre-OST0000-osc-ffff89781800a800@192.168.202.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1786750960 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4758.518340] Lustre: lustre-OST0000-osc-ffff89781800a800: Connection to lustre-OST0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4763.488433] Lustre: 95433:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786750949/real 1786750949] req@0000000052bb9e75 x1873544019449600/t0(0) o400->lustre-OST0000-osc-ffff89781800a800@192.168.202.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1786750965 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4768.676366] Lustre: 95433:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786750954/real 1786750954] req@000000006c297833 x1873544019450112/t0(0) o400->lustre-OST0000-osc-ffff89781800a800@192.168.202.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1786750970 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4768.758382] Lustre: lustre-MDT0000-mdc-ffff89781800a800: Connection to lustre-MDT0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4768.813388] Lustre: lustre-OST0000-osc-ffff89781800a800: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [ 4772.832920] Lustre: 95432:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786750959/real 1786750959] req@00000000048d65fd x1873544019450624/t0(0) o400->lustre-OST0000-osc-ffff89781800a800@192.168.202.137@tcp:28/4 lens 224/224 e 0 to 1 dl 1786750975 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4790.112275] Lustre: 95432:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786750976/real 1786750976] req@000000008a74c5d5 x1873544019452928/t0(0) o400->MGC192.168.202.137@tcp@192.168.202.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1786750992 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4790.148058] LustreError: MGC192.168.202.137@tcp: Connection to MGS (at 192.168.202.137@tcp) was lost; in progress operations using this service will fail [ 4790.184260] Lustre: Evicted from MGS (at 192.168.202.137@tcp) after server handle changed from 0xe294b0803acd6118 to 0xe294b0803acd62a7 [ 4790.203184] Lustre: MGC192.168.202.137@tcp: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [ 4797.439072] Lustre: 98608:0:(mgc_request.c:1899:mgc_process_log()) MGC192.168.202.137@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 4804.547527] Lustre: lustre-MDT0000-mdc-ffff89781800a800: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [ 4811.778416] Lustre: Unmounted lustre-client [ 4841.601601] Key type lgssc unregistered [ 4841.968605] LNet: 99740:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4841.984991] LNetError: 99740:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4842.022872] LNet: Removed LNI 192.168.202.37@tcp [ 4842.992742] Key type .llcrypt unregistered [ 4842.995373] Key type ._llcrypt unregistered [ 4861.475264] Key type ._llcrypt registered [ 4861.476769] Key type .llcrypt registered [ 4863.280049] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 19:44:23 (1786751063) [ 4878.622915] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4878.746428] alg: No test for adler32 (adler32-zlib) [ 4879.817317] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 4879.968931] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 4881.624970] Key type lgssc registered [ 4883.134640] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4930.119861] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5033.793541] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5039.728881] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5066.432292] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5068.141275] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 5070.290035] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5072.499594] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 19:47:53 (1786751273) [ 5315.604637] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5325.970336] Lustre: Unmounted lustre-client [ 5448.828231] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5453.966645] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5476.290735] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5519.236699] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:55:20 (1786751720) [ 5622.269507] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5629.552082] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5655.357485] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5656.153447] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 5661.148649] Lustre: Unmounted lustre-client [ 5702.654253] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:58:23 (1786751903) [ 5812.039259] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5817.757182] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5843.093115] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5844.322313] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 5849.402473] Lustre: Unmounted lustre-client [ 5880.558800] Key type lgssc unregistered [ 5880.818387] LNet: 122791:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5880.825131] LNetError: 122791:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5880.843073] LNet: Removed LNI 192.168.202.37@tcp [ 5881.450776] Key type .llcrypt unregistered [ 5881.452837] Key type ._llcrypt unregistered [ 5898.366461] Key type ._llcrypt registered [ 5898.370619] Key type .llcrypt registered [ 5899.554179] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 20:01:40 (1786752100) [ 5902.520603] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5902.545726] alg: No test for adler32 (adler32-zlib) [ 5903.611436] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 5903.797776] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 5905.416284] Key type lgssc registered [ 5906.515609] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5963.315258] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5969.123164] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5995.907199] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5998.738422] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 6012.862804] Lustre: Unmounted lustre-client [ 6044.576668] Key type lgssc unregistered [ 6044.943483] LNet: 126395:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6044.952600] LNetError: 126395:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6044.981462] LNet: Removed LNI 192.168.202.37@tcp [ 6045.890794] Key type .llcrypt unregistered [ 6045.903636] Key type ._llcrypt unregistered [ 6063.621968] Key type ._llcrypt registered [ 6063.623438] Key type .llcrypt registered [ 6065.771846] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 20:04:25 (1786752265) [ 6069.649712] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6069.711297] alg: No test for adler32 (adler32-zlib) [ 6071.303570] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 6071.594403] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 6073.360208] Key type lgssc registered [ 6074.710669] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6132.658969] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6140.043776] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6162.923165] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6164.606837] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 6174.723927] Lustre: lustre-OST0000-osc-ffff89781800a800: Connection to lustre-OST0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6186.941822] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff89781800a800.ost_server_uuid 50 [ 6189.041453] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6200.607829] Lustre: Unmounted lustre-client [ 6220.977995] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 20:07:01 (1786752421) [ 6258.538814] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6264.820601] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6291.609894] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6317.733233] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6318.445591] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 6323.695192] Lustre: lustre-OST0000-osc-ffff8978064ed000: Connection to lustre-OST0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6352.473593] Lustre: Unmounted lustre-client [ 6404.485411] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 20:10:05 (1786752605) [ 6440.231105] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6446.855419] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6469.069447] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6493.936252] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6494.488939] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 6499.827809] Lustre: lustre-OST0000-osc-ffff897810f38000: Connection to lustre-OST0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6524.945354] Lustre: Unmounted lustre-client [ 6578.509256] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 20:12:58 (1786752778) [ 6685.448531] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6693.208129] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6719.091376] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6800.153877] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6808.105839] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6834.256821] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6866.971941] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 6916.030463] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6917.837159] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6920.034017] Lustre: Unmounted lustre-client [ 6955.390889] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 20:19:16 (1786753156) [ 6994.125197] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7002.119719] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7023.954249] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7069.509756] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7105.915362] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 7152.171145] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7154.034407] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7168.387254] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7178.717177] Lustre: Unmounted lustre-client [ 7240.825719] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 20:24:01 (1786753441) [ 7280.256553] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7288.027346] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7314.002657] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7314.716542] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 7339.926792] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7341.624549] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7359.615212] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff89780869d000.ost_server_uuid 50 [ 7361.418216] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff89780869d000.ost_server_uuid in IDLE state after 0 sec [ 7364.906508] Lustre: Unmounted lustre-client [ 7365.368849] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7365.373716] Lustre: Skipped 3 previous similar messages [ 7365.437262] LustreError: 127352:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 7365.477527] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 7367.353775] LustreError: 149827:0:(sec.c:403:import_sec_validate_get()) import 000000000a2bca3a (NEW) with no sec [ 7441.607457] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 20:27:22 (1786753642) [ 7480.872480] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7488.570232] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7517.355586] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7541.237044] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7541.859961] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7542.046830] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 7552.487585] Lustre: Unmounted lustre-client [ 7552.492375] Lustre: Skipped 1 previous similar message [ 7598.433185] Key type lgssc unregistered [ 7598.690973] LNet: 153249:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7598.698336] LNetError: 153249:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7598.717931] LNet: Removed LNI 192.168.202.37@tcp [ 7599.318085] Key type .llcrypt unregistered [ 7599.319806] Key type ._llcrypt unregistered [ 7616.461071] Key type ._llcrypt registered [ 7616.463669] Key type .llcrypt registered [ 7618.283750] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 20:30:18 (1786753818) [ 7619.229548] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7619.394964] alg: No test for adler32 (adler32-zlib) [ 7620.459551] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 7620.671171] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 7622.336742] Key type lgssc registered [ 7623.411878] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7681.579868] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7688.877319] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7715.061976] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7740.502201] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7742.466716] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7743.712789] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 7747.180251] LustreError: lustre-MDT0001-mdc-ffff8978119b2800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7747.201127] Lustre: lustre-MDT0001-mdc-ffff8978119b2800: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [ 7755.067660] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7756.754469] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7781.891770] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7787.448945] Lustre: Unmounted lustre-client [ 7821.229705] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 20:33:42 (1786754022) [ 7929.786654] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7936.452752] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7967.711484] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7968.254641] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 7996.141695] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7997.979762] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8010.340926] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8020.782144] Lustre: Unmounted lustre-client [ 8055.861193] Key type lgssc unregistered [ 8056.080814] LNet: 162879:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8056.103176] LNetError: 162879:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8056.125752] LNet: Removed LNI 192.168.202.37@tcp [ 8056.701499] Key type .llcrypt unregistered [ 8056.703688] Key type ._llcrypt unregistered [ 8091.046532] Key type ._llcrypt registered [ 8091.050354] Key type .llcrypt registered [ 8092.871744] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 20:38:13 (1786754293) [ 8095.529822] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8095.558661] alg: No test for adler32 (adler32-zlib) [ 8096.663166] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 8096.869737] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 8098.513357] Key type lgssc registered [ 8099.823666] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8160.054293] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8166.632973] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8190.368468] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8192.106600] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 8237.463309] Lustre: Unmounted lustre-client [ 8287.219073] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8288.513855] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 8325.722219] Lustre: Unmounted lustre-client [ 8353.263442] Key type lgssc unregistered [ 8353.493214] LNet: 167335:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8353.498942] LNetError: 167335:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8353.519147] LNet: Removed LNI 192.168.202.37@tcp [ 8354.201297] Key type .llcrypt unregistered [ 8354.205637] Key type ._llcrypt unregistered [ 8369.673276] Key type ._llcrypt registered [ 8369.676495] Key type .llcrypt registered [ 8371.305489] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 20:42:51 (1786754571) [ 8374.150724] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8374.245343] alg: No test for adler32 (adler32-zlib) [ 8375.281124] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 8375.812968] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 8377.616224] Key type lgssc registered [ 8379.159861] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8441.559865] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8448.425935] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8475.564671] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8481.848637] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 8502.817285] Lustre: Unmounted lustre-client [ 8539.592724] Key type lgssc unregistered [ 8539.787989] LNet: 171101:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8539.793523] LNetError: 171101:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8539.809660] LNet: Removed LNI 192.168.202.37@tcp [ 8540.387656] Key type .llcrypt unregistered [ 8540.389523] Key type ._llcrypt unregistered [ 8554.194667] Key type ._llcrypt registered [ 8554.197490] Key type .llcrypt registered [ 8554.554468] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8554.567407] alg: No test for adler32 (adler32-zlib) [ 8555.718864] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 8556.244435] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 8557.928240] Key type lgssc registered [ 8559.223278] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8616.709856] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8622.704114] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8647.790226] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8660.015674] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 8668.624482] Lustre: Unmounted lustre-client [ 8699.078578] Key type lgssc unregistered [ 8699.588745] LNet: 174172:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8699.616704] LNetError: 174172:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8699.645632] LNet: Removed LNI 192.168.202.37@tcp [ 8700.587848] Key type .llcrypt unregistered [ 8700.595234] Key type ._llcrypt unregistered [ 8719.449623] Key type ._llcrypt registered [ 8719.452592] Key type .llcrypt registered [ 8720.927234] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 20:48:41 (1786754921) [ 8724.542803] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8724.605196] alg: No test for adler32 (adler32-zlib) [ 8725.817925] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 8726.181125] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 8727.904189] Key type lgssc registered [ 8730.119347] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8790.673454] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8798.655873] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8824.889842] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8831.606103] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 8854.874735] Lustre: Unmounted lustre-client [ 8893.028902] Key type lgssc unregistered [ 8893.239251] LNet: 177941:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8893.244442] LNetError: 177941:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8893.264117] LNet: Removed LNI 192.168.202.37@tcp [ 8893.773541] Key type .llcrypt unregistered [ 8893.775745] Key type ._llcrypt unregistered [ 8907.991226] Key type ._llcrypt registered [ 8907.994079] Key type .llcrypt registered [ 8908.433233] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8908.443974] alg: No test for adler32 (adler32-zlib) [ 8909.557421] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 8909.739739] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 8911.393158] Key type lgssc registered [ 8912.897554] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8969.088233] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8974.945354] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8999.991969] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9003.246498] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 9010.781742] Lustre: Unmounted lustre-client [ 9047.578810] Key type lgssc unregistered [ 9047.768137] LNet: 181011:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9047.779181] LNetError: 181011:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9047.791391] LNet: Removed LNI 192.168.202.37@tcp [ 9048.631222] Key type .llcrypt unregistered [ 9048.635703] Key type ._llcrypt unregistered [ 9072.313559] Key type ._llcrypt registered [ 9072.319667] Key type .llcrypt registered [ 9074.309521] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 20:54:34 (1786755274) [ 9102.606114] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9102.630496] alg: No test for adler32 (adler32-zlib) [ 9104.118668] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 9104.532485] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 9106.336245] Key type lgssc registered [ 9108.111513] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9210.886953] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9216.515840] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9240.658865] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9292.461001] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 20:58:13 (1786755493) [ 9331.064157] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9338.954056] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9363.974840] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9371.226458] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 9377.708350] Lustre: Unmounted lustre-client [ 9402.011956] Key type lgssc unregistered [ 9402.273246] LNet: 188125:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9402.286676] LNetError: 188125:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9402.306275] LNet: Removed LNI 192.168.202.37@tcp [ 9403.072680] Key type .llcrypt unregistered [ 9403.075674] Key type ._llcrypt unregistered [ 9417.075480] Key type ._llcrypt registered [ 9417.077696] Key type .llcrypt registered [ 9418.147697] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9419.531462] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 21:00:20 (1786755620) [ 9435.956909] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9436.016048] alg: No test for adler32 (adler32-zlib) [ 9437.012295] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 9437.248578] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 9438.930367] Key type lgssc registered [ 9440.758587] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9538.679873] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9543.576854] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9567.529783] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9588.534956] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9590.159303] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [ 9610.482859] Lustre: Unmounted lustre-client [ 9744.454940] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9750.542130] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9776.372065] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9820.994691] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 21:07:01 (1786756021) [ 9822.565216] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9824.602692] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 21:07:05 (1786756025) [ 9923.624267] Key type lgssc unregistered [ 9923.837967] LNet: 199584:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9923.845841] LNetError: 199584:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9923.858853] LNet: Removed LNI 192.168.202.37@tcp [ 9924.501255] Key type .llcrypt unregistered [ 9924.508370] Key type ._llcrypt unregistered [ 9943.503497] Key type ._llcrypt registered [ 9943.508232] Key type .llcrypt registered [ 9945.415758] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 21:09:05 (1786756145) [ 9987.677942] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9987.758243] alg: No test for adler32 (adler32-zlib) [ 9989.083512] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [ 9989.499285] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [ 9991.264813] Key type lgssc registered [ 9993.304359] Lustre: Echo OBD driver; http://www.lustre.org/ [10041.047821] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10049.034845] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10088.033781] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10117.633940] Key type lgssc unregistered [10118.046106] LNet: 203322:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10118.060534] LNetError: 203322:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10118.087576] LNet: Removed LNI 192.168.202.37@tcp [10119.216788] Key type .llcrypt unregistered [10119.220619] Key type ._llcrypt unregistered [10136.280772] Key type ._llcrypt registered [10136.283423] Key type .llcrypt registered [10138.349961] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 21:12:18 (1786756338) [10142.291997] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10142.397099] alg: No test for adler32 (adler32-zlib) [10143.736821] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [10144.316390] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [10146.178250] Key type lgssc registered [10147.895105] Lustre: Echo OBD driver; http://www.lustre.org/ [10205.781624] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10212.530793] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10236.245986] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10239.276738] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [10249.725713] Lustre: lustre-MDT0000-mdc-ffff89780531a000: Connection to lustre-MDT0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [10259.948353] Lustre: lustre-MDT0001-mdc-ffff89780531a000: Connection to lustre-MDT0001 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [10271.200362] Lustre: 204317:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786756457/real 1786756457] req@0000000028dad9b7 x1873549822345216/t0(0) o400->MGC192.168.202.137@tcp@192.168.202.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1786756473 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10271.232296] LustreError: MGC192.168.202.137@tcp: Connection to MGS (at 192.168.202.137@tcp) was lost; in progress operations using this service will fail [10295.789659] Lustre: Evicted from MGS (at 192.168.202.137@tcp) after server handle changed from 0x1803641f868486da to 0x1803641f8684a01e [10295.802936] Lustre: MGC192.168.202.137@tcp: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [10326.517875] LustreError: lustre-MDT0000-mdc-ffff89780531a000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10326.565901] Lustre: lustre-MDT0000-mdc-ffff89780531a000: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [10331.847331] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10333.416776] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10338.790900] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10340.575749] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10344.016715] Lustre: Unmounted lustre-client [10372.201604] Key type lgssc unregistered [10372.433734] LNet: 208281:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10372.437740] LNetError: 208281:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10372.453767] LNet: Removed LNI 192.168.202.37@tcp [10373.254730] Key type .llcrypt unregistered [10373.258061] Key type ._llcrypt unregistered [10390.904535] Key type ._llcrypt registered [10390.910393] Key type .llcrypt registered [10392.426825] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 21:16:32 (1786756592) [10395.730034] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10395.778184] alg: No test for adler32 (adler32-zlib) [10396.891864] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [10397.161445] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [10398.904246] Key type lgssc registered [10400.231344] Lustre: Echo OBD driver; http://www.lustre.org/ [10453.666588] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10461.358836] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10515.429835] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10521.998748] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10559.122694] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10587.641657] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10640.633280] Key type lgssc unregistered [10641.334908] LNet: 213582:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10641.357637] LNetError: 213582:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10641.394776] LNet: Removed LNI 192.168.202.37@tcp [10643.253675] Key type .llcrypt unregistered [10643.257707] Key type ._llcrypt unregistered [10694.229538] Key type ._llcrypt registered [10694.232689] Key type .llcrypt registered [10696.209194] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 21:21:35 (1786756895) [10743.052372] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10743.081757] alg: No test for adler32 (adler32-zlib) [10744.251316] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [10744.552929] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [10746.234428] Key type lgssc registered [10747.739759] Lustre: Echo OBD driver; http://www.lustre.org/ [10828.435309] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10834.909136] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10862.148404] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10906.833168] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 21:25:07 (1786757107) [10917.330194] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 21:25:17 (1786757117) [10959.025769] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10966.443091] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10995.030679] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11007.548596] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [11014.410760] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [11017.623976] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [11019.669530] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [11021.946102] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [11027.950486] Lustre: lustre-MDT0000-mdc-ffff897805318800: Connection to lustre-MDT0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [11044.320202] Lustre: 215480:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786757230/real 1786757230] req@00000000fac12c48 x1873550451419648/t0(0) o400->MGC192.168.202.137@tcp@192.168.202.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1786757246 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11044.349847] LustreError: MGC192.168.202.137@tcp: Connection to MGS (at 192.168.202.137@tcp) was lost; in progress operations using this service will fail [11044.397929] Lustre: Evicted from MGS (at 192.168.202.137@tcp) after server handle changed from 0x4589e54e2b5a2a3e to 0x4589e54e2b5a2bbf [11044.408687] Lustre: MGC192.168.202.137@tcp: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [11049.924351] Lustre: lustre-MDT0000-mdc-ffff897805318800: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [11058.893310] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11060.259668] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11064.037293] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [11069.937622] Lustre: lustre-MDT0000-mdc-ffff897805318800: Connection to lustre-MDT0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [11086.304462] Lustre: 215480:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786757272/real 1786757272] req@0000000028075fa5 x1873550451427968/t0(0) o400->MGC192.168.202.137@tcp@192.168.202.137@tcp:26/25 lens 224/224 e 0 to 1 dl 1786757288 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11086.333927] LustreError: MGC192.168.202.137@tcp: Connection to MGS (at 192.168.202.137@tcp) was lost; in progress operations using this service will fail [11086.360162] Lustre: Evicted from MGS (at 192.168.202.137@tcp) after server handle changed from 0x4589e54e2b5a2bbf to 0x4589e54e2b5a2fc4 [11086.376067] Lustre: MGC192.168.202.137@tcp: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [11090.962568] Lustre: lustre-MDT0000-mdc-ffff897805318800: Connection restored to 192.168.202.137@tcp (at 192.168.202.137@tcp) [11106.563844] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11108.755334] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11113.202449] Lustre: Unmounted lustre-client [11191.503223] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11198.534297] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11227.443566] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11233.903626] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [11238.055124] Lustre: Unmounted lustre-client [11267.674196] Key type lgssc unregistered [11267.863738] LNet: 226067:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11267.873698] LNetError: 226067:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11267.883534] LNet: Removed LNI 192.168.202.37@tcp [11268.453677] Key type .llcrypt unregistered [11268.455119] Key type ._llcrypt unregistered [11286.926181] Key type ._llcrypt registered [11286.928283] Key type .llcrypt registered [11289.194281] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 21:31:28 (1786757488) [11296.094052] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11296.209639] alg: No test for adler32 (adler32-zlib) [11297.545075] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [11298.048244] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [11299.920220] Key type lgssc registered [11302.376212] Lustre: Echo OBD driver; http://www.lustre.org/ [11359.849373] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11369.129074] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11395.420828] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11402.339265] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [11410.105457] Lustre: Unmounted lustre-client [11480.424484] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11487.958673] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11512.841559] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11519.112426] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [11528.297832] Lustre: Unmounted lustre-client [11611.579969] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11619.907599] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11650.290271] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11651.085610] LustreError: 227071:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [11651.153326] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [11654.986148] Lustre: Unmounted lustre-client [11686.313268] Key type lgssc unregistered [11686.648969] LNet: 233137:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11686.668115] LNetError: 233137:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11686.681369] LNet: Removed LNI 192.168.202.37@tcp [11687.361651] Key type .llcrypt unregistered [11687.363889] Key type ._llcrypt unregistered [11705.001589] Key type ._llcrypt registered [11705.003642] Key type .llcrypt registered [11706.274361] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 21:38:27 (1786757907) [11710.304615] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11710.437590] alg: No test for adler32 (adler32-zlib) [11711.577769] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [11711.824894] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [11713.488203] Key type lgssc registered [11714.905362] Lustre: Echo OBD driver; http://www.lustre.org/ [11769.355562] Key type lgssc unregistered [11769.550853] LNet: 235463:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11769.557625] LNetError: 235463:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11769.578885] LNet: Removed LNI 192.168.202.37@tcp [11770.299681] Key type .llcrypt unregistered [11770.301490] Key type ._llcrypt unregistered [11802.593199] Key type ._llcrypt registered [11802.595859] Key type .llcrypt registered [11803.186618] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11803.200603] alg: No test for adler32 (adler32-zlib) [11804.381228] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [11804.706257] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [11806.464156] Key type lgssc registered [11807.837935] Lustre: Echo OBD driver; http://www.lustre.org/ [11895.630582] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11901.675845] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11929.679250] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11975.610439] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11977.996381] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 21:42:58 (1786758178) [12015.020315] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12021.579612] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12049.236429] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12076.048972] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12077.813927] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [12083.190449] Lustre: lustre-OST0001-osc-ffff89780869a800: Connection to lustre-OST0001 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [12089.266355] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12099.651374] Lustre: Unmounted lustre-client [12137.157916] Key type lgssc unregistered [12137.467286] LNet: 242579:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12137.473979] LNetError: 242579:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12138.542637] LNet: Removed LNI 192.168.202.37@tcp [12139.683169] Key type .llcrypt unregistered [12139.685932] Key type ._llcrypt unregistered [12175.060404] Key type ._llcrypt registered [12175.062423] Key type .llcrypt registered [12176.351738] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 21:46:17 (1786758377) [12191.317079] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12191.341663] alg: No test for adler32 (adler32-zlib) [12192.415937] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [12192.672525] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [12194.320282] Key type lgssc registered [12196.369321] Lustre: Echo OBD driver; http://www.lustre.org/ [12253.690434] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12261.427740] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12289.843059] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 21:48:10 (1786758490) [12335.006476] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12343.722622] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12369.858132] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12372.748876] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [12379.154474] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12389.872533] Lustre: Unmounted lustre-client [12502.723195] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12510.410631] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12568.888169] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12569.674745] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [12573.012366] Lustre: Unmounted lustre-client [12600.726443] Key type lgssc unregistered [12601.064524] LNet: 250265:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12601.072747] LNetError: 250265:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12601.098908] LNet: Removed LNI 192.168.202.37@tcp [12601.940631] Key type .llcrypt unregistered [12601.943489] Key type ._llcrypt unregistered [12639.167093] Key type ._llcrypt registered [12639.196049] Key type .llcrypt registered [12639.583571] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12639.593426] alg: No test for adler32 (adler32-zlib) [12640.800919] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [12641.187827] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [12642.856186] Key type lgssc registered [12644.415594] Lustre: Echo OBD driver; http://www.lustre.org/ [12745.498766] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12751.563646] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12777.217302] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12823.533368] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12825.063677] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 21:57:06 (1786759026) [12863.169527] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12871.050417] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12894.455991] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12904.523620] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [12907.745900] Lustre: Unmounted lustre-client [12945.434721] Key type lgssc unregistered [12945.712887] LNet: 256903:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12945.727288] LNetError: 256903:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12945.763496] LNet: Removed LNI 192.168.202.37@tcp [12946.435131] Key type .llcrypt unregistered [12946.437689] Key type ._llcrypt unregistered [12966.252677] Key type ._llcrypt registered [12966.254810] Key type .llcrypt registered [12968.112228] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12970.346450] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 21:59:30 (1786759170) [12984.275510] Key type .llcrypt unregistered [12984.278259] Key type ._llcrypt unregistered [12994.035183] Key type ._llcrypt registered [12994.040018] Key type .llcrypt registered [12994.375903] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12994.385248] alg: No test for adler32 (adler32-zlib) [12995.595765] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [12996.119783] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [12997.824247] Key type lgssc registered [12999.980070] Lustre: Echo OBD driver; http://www.lustre.org/ [13056.486377] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13075.776115] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [13079.452274] Lustre: Unmounted lustre-client [13105.814628] Key type lgssc unregistered [13106.101903] LNet: 260394:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13106.109367] LNetError: 260394:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13106.136636] LNet: Removed LNI 192.168.202.37@tcp [13106.723591] Key type .llcrypt unregistered [13106.725833] Key type ._llcrypt unregistered [13123.045718] Key type ._llcrypt registered [13123.047748] Key type .llcrypt registered [13125.031838] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 22:02:05 (1786759325) [13127.256391] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13127.284475] alg: No test for adler32 (adler32-zlib) [13128.388845] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [13128.746373] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [13130.496432] Key type lgssc registered [13132.064525] Lustre: Echo OBD driver; http://www.lustre.org/ [13226.782624] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13263.654349] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13272.922958] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13275.502181] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [13277.869520] Lustre: Unmounted lustre-client [13308.805519] Key type lgssc unregistered [13309.047820] LNet: 263940:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13309.055104] LNetError: 263940:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13309.067503] LNet: Removed LNI 192.168.202.37@tcp [13309.782912] Key type .llcrypt unregistered [13309.788103] Key type ._llcrypt unregistered [13329.492184] Key type ._llcrypt registered [13329.496914] Key type .llcrypt registered [13332.111894] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 22:05:31 (1786759531) [13337.125411] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13337.138790] alg: No test for adler32 (adler32-zlib) [13338.332751] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [13338.553454] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [13340.208245] Key type lgssc registered [13342.846589] Lustre: Echo OBD driver; http://www.lustre.org/ [13400.969986] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13407.716309] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13435.344439] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13442.634992] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [13447.671680] Lustre: lustre-MDT0000-mdc-ffff897808698000: Connection to lustre-MDT0000 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [13453.505609] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13453.549376] LustreError: 267106:0:(file.c:6156:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13454.059888] LustreError: MGC192.168.202.137@tcp: Connection to MGS (at 192.168.202.137@tcp) was lost; in progress operations using this service will fail [13454.174868] Lustre: Unmounted lustre-client [13477.172518] Key type lgssc unregistered [13477.709659] LNet: 267522:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13477.720393] LNetError: 267522:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13477.731798] LNet: Removed LNI 192.168.202.37@tcp [13478.158630] Key type .llcrypt unregistered [13478.159923] Key type ._llcrypt unregistered [13500.382928] Key type ._llcrypt registered [13500.389453] Key type .llcrypt registered [13502.070185] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 22:08:22 (1786759702) [13504.690767] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13504.731953] alg: No test for adler32 (adler32-zlib) [13506.102364] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [13506.414372] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [13508.048384] Key type lgssc registered [13509.209183] Lustre: Echo OBD driver; http://www.lustre.org/ [13568.276947] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13574.590506] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13597.762986] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13599.471922] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [13611.075557] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13613.612322] Lustre: Unmounted lustre-client [13636.640211] Key type lgssc unregistered [13636.843394] LNet: 271108:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13636.847847] LNetError: 271108:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13636.869290] LNet: Removed LNI 192.168.202.37@tcp [13637.373584] Key type .llcrypt unregistered [13637.379598] Key type ._llcrypt unregistered [13655.894194] Key type ._llcrypt registered [13655.898226] Key type .llcrypt registered [13657.846705] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 22:10:57 (1786759857) [13679.549936] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13679.647219] alg: No test for adler32 (adler32-zlib) [13680.835953] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [13681.134493] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [13682.864870] Key type lgssc registered [13684.266495] Lustre: Echo OBD driver; http://www.lustre.org/ [13799.003176] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13801.038274] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [13853.669748] Lustre: lustre-MDT0001-mdc-ffff897805ad4800: Connection to lustre-MDT0001 (at 192.168.202.137@tcp) was lost; in progress operations using this service will wait for recovery to complete [13860.237529] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13870.568486] Lustre: Unmounted lustre-client [13900.448777] Key type lgssc unregistered [13900.876466] LNet: 276905:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13900.880904] LNetError: 276905:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13900.900459] LNet: Removed LNI 192.168.202.37@tcp [13902.264085] Key type .llcrypt unregistered [13902.270793] Key type ._llcrypt unregistered [13922.076752] Key type ._llcrypt registered [13922.078965] Key type .llcrypt registered [13923.560755] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 22:15:23 (1786760123) [13925.580664] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13927.791076] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 22:15:28 (1786760128) [13929.145605] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13931.299371] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 22:15:32 (1786760132) [13933.284954] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13935.447553] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 22:15:35 (1786760135) [13937.214607] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13939.715964] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 22:15:40 (1786760140) [13941.834700] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13943.510271] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 22:15:44 (1786760144) [13954.006918] Key type .llcrypt unregistered [13954.011441] Key type ._llcrypt unregistered [13963.249301] Key type ._llcrypt registered [13963.254495] Key type .llcrypt registered [13963.929346] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13963.946843] alg: No test for adler32 (adler32-zlib) [13965.062562] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [13965.282636] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [13966.979762] Key type lgssc registered [13968.396468] Lustre: Echo OBD driver; http://www.lustre.org/ [14056.858476] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14063.934632] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14087.570714] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14089.571124] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [14091.878780] Lustre: Unmounted lustre-client [14131.705331] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 22:18:52 (1786760332) [14181.642994] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14188.429707] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14227.868088] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14228.838754] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [14230.866533] Lustre: Unmounted lustre-client [14279.712314] LNet: 1 local NIs in recovery (showing 1): 192.168.202.37@tcp [14282.421755] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 22:21:23 (1786760483) [14944.198993] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14951.802638] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14989.615139] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15115.875786] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 22:35:16 (1786761316) [15130.441195] Key type lgssc unregistered [15130.800857] LNet: 290474:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15130.816839] LNetError: 290474:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15130.848299] LNet: Removed LNI 192.168.202.37@tcp [15131.568725] Key type .llcrypt unregistered [15131.571173] Key type ._llcrypt unregistered [15239.880556] Key type ._llcrypt registered [15239.885764] Key type .llcrypt registered [15240.714454] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15240.729454] alg: No test for adler32 (adler32-zlib) [15241.794438] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [15242.002682] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [15243.752475] Key type lgssc registered [15245.365522] Lustre: Echo OBD driver; http://www.lustre.org/ [15348.242714] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15353.777533] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15378.355318] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15424.919411] Key type lgssc unregistered [15425.285117] LNet: 294179:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15425.288688] LNetError: 294179:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15425.301601] LNet: Removed LNI 192.168.202.37@tcp [15426.198296] Key type .llcrypt unregistered [15426.201223] Key type ._llcrypt unregistered [15465.886388] Key type ._llcrypt registered [15465.893665] Key type .llcrypt registered [15467.000610] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 22:41:07 (1786761667) [15490.629768] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15490.677447] alg: No test for adler32 (adler32-zlib) [15491.720674] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [15491.925666] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [15493.576498] Key type lgssc registered [15495.008068] Lustre: Echo OBD driver; http://www.lustre.org/ [15547.980886] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 22:42:29 (1786761749) [15560.820645] Key type lgssc unregistered [15561.094529] LNet: 297748:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15561.114184] LNetError: 297748:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15561.149042] LNet: Removed LNI 192.168.202.37@tcp [15561.931805] Key type .llcrypt unregistered [15561.936331] Key type ._llcrypt unregistered [15572.616456] Key type ._llcrypt registered [15572.619507] Key type .llcrypt registered [15573.217780] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15573.251894] alg: No test for adler32 (adler32-zlib) [15574.254232] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [15574.583302] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [15576.408936] Key type lgssc registered [15577.659214] Lustre: Echo OBD driver; http://www.lustre.org/ [15641.979118] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15648.923253] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15675.046949] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15991.173253] LNet: Added LNI 192.168.202.37@tcp50 [8/256/0/180] [15993.090867] LNet: Removed LNI 192.168.202.37@tcp [15995.320872] Lustre: 302145:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff89780b4e3000: config has no valid NIDs, force dynamic NIDs [15996.593426] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [15996.784601] Lustre: Unmounted lustre-client [16000.526454] Key type lgssc unregistered [16000.795308] LNet: 302408:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16000.800916] LNetError: 302408:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16000.814653] LNet: Removed LNI 192.168.202.37@tcp50 [16001.253960] Key type .llcrypt unregistered [16001.256336] Key type ._llcrypt unregistered [16021.140241] Key type ._llcrypt registered [16021.143510] Key type .llcrypt registered [16021.818946] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [16021.850377] alg: No test for adler32 (adler32-zlib) [16023.127251] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [16023.429510] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [16025.144261] Key type lgssc registered [16026.927799] Lustre: Echo OBD driver; http://www.lustre.org/ [16090.023415] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16097.467311] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16106.398158] LNet: Added LNI 192.168.202.37@tcp50 [8/256/0/180] [16107.395114] LNet: Removed LNI 192.168.202.37@tcp [16108.619305] Lustre: 305099:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8978047d3800: config has no valid NIDs, force dynamic NIDs [16109.819897] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [16110.631753] Lustre: Unmounted lustre-client [16146.961972] Key type lgssc unregistered [16147.210828] LNet: 305971:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16147.215955] LNetError: 305971:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16147.231348] LNet: Removed LNI 192.168.202.37@tcp50 [16147.808584] Key type .llcrypt unregistered [16147.810734] Key type ._llcrypt unregistered [16161.523474] Key type ._llcrypt registered [16161.525706] Key type .llcrypt registered [16162.888411] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 22:52:43 (1786762363) [16184.564176] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16184.578438] alg: No test for adler32 (adler32-zlib) [16185.625615] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [16185.843188] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [16187.488222] Key type lgssc registered [16188.911974] Lustre: Echo OBD driver; http://www.lustre.org/ [16280.259431] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16285.489940] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16313.343991] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16349.050922] Key type lgssc unregistered [16349.271981] LNet: 310722:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16349.276726] LNetError: 310722:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16349.288206] LNet: Removed LNI 192.168.202.37@tcp [16349.958907] Key type .llcrypt unregistered [16349.961200] Key type ._llcrypt unregistered [16362.231417] Key type ._llcrypt registered [16362.232886] Key type .llcrypt registered [16363.976546] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 22:56:04 (1786762564) [16367.909632] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16367.980158] alg: No test for adler32 (adler32-zlib) [16369.269485] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [16369.717407] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [16371.505178] Key type lgssc registered [16373.135503] Lustre: Echo OBD driver; http://www.lustre.org/ [16429.296925] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16435.174701] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16461.604519] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16463.865714] Lustre: Mounted lustre-client - version 2.17.57_3_g6085841 [16527.039960] Lustre: Mounted fs15246-client - version 2.17.57_3_g6085841 [16544.141540] Lustre: Unmounted fs15246-client [16576.733579] Lustre: Unmounted lustre-client [16615.712443] Key type lgssc unregistered [16616.002886] LNet: 315581:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16616.009732] LNetError: 315581:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16616.033771] LNet: Removed LNI 192.168.202.37@tcp [16616.993503] Key type .llcrypt unregistered [16617.002239] Key type ._llcrypt unregistered [16631.599751] Key type ._llcrypt registered [16631.601508] Key type .llcrypt registered [16633.206085] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 23:00:33 (1786762833) [16635.230641] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16635.465376] alg: No test for adler32 (adler32-zlib) [16636.471312] Lustre: Lustre: Build Version: 2.17.57_3_g6085841 [16636.658553] LNet: Added LNI 192.168.202.37@tcp [8/256/0/180] [16638.312602] Key type lgssc registered [16640.217292] Lustre: Echo OBD driver; http://www.lustre.org/ [16787.962671] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16793.903658] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16822.416746] Lustre: DEBUG MARKER: oleg237-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16947.932560] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16614 sec ========= 23:05:48 (1786763148) [16950.049414] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 23:05:50 (1786763150) === [16953.901256] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 23:05:54 (1786763154) === [17000.374809] Key type lgssc unregistered [17000.643042] LNet: 324866:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17000.652147] LNetError: 324866:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17000.663791] LNet: Removed LNI 192.168.202.37@tcp [17001.338654] Key type .llcrypt unregistered [17001.345486] Key type ._llcrypt unregistered