[ 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 537486002 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.002384] x2apic enabled [ 0.004004] Switched APIC routing to physical x2apic. [ 0.006009] kvm-guest: setup PV IPIs [ 0.009000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.009000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.009018] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010010] pid_max: default: 32768 minimum: 301 [ 0.012054] LSM: Security Framework initializing [ 0.013043] Yama: becoming mindful. [ 0.015030] SELinux: Initializing. [ 0.016069] *** VALIDATE selinux *** [ 0.024802] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.029478] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.030146] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031105] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032108] *** VALIDATE tmpfs *** [ 0.034123] *** VALIDATE proc *** [ 0.035226] *** VALIDATE cgroup *** [ 0.036011] *** VALIDATE cgroup2 *** [ 0.037269] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038150] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.039007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.040028] Spectre V2 : User space: Vulnerable [ 0.041008] Speculative Store Bypass: Vulnerable [ 0.043844] debug: unmapping init [mem 0xffffffffa9259000-0xffffffffa9260fff] [ 0.045252] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046786] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047021] ... version: 2 [ 0.048010] ... bit width: 48 [ 0.049013] ... generic registers: 4 [ 0.050011] ... value mask: 0000ffffffffffff [ 0.051011] ... max period: 00007fffffffffff [ 0.052013] ... fixed-purpose events: 3 [ 0.053011] ... event mask: 000000070000000f [ 0.054335] rcu: Hierarchical SRCU implementation. [ 0.056593] smp: Bringing up secondary CPUs ... [ 0.057554] x86: Booting SMP configuration: [ 0.058023] .... node #0, CPUs: #1 #2 #3 [ 0.061258] smp: Brought up 1 node, 4 CPUs [ 0.063011] smpboot: Max logical packages: 1 [ 0.064018] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.132099] node 0 deferred pages initialised in 64ms [ 0.134128] devtmpfs: initialized [ 0.135246] x86/mm: Memory block size: 128MB [ 0.138324] gcov: version magic: 0x41383552 [ 0.140463] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.145462] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.147291] pinctrl core: initialized pinctrl subsystem [ 0.150167] [ 0.150732] ************************************************************* [ 0.153011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.156015] ** ** [ 0.159013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.162010] ** ** [ 0.164010] ** This means that this kernel is built to expose internal ** [ 0.167013] ** IOMMU data structures, which may compromise security on ** [ 0.169009] ** your system. ** [ 0.172011] ** ** [ 0.174010] ** If you see this message and you are not debugging the ** [ 0.175010] ** kernel, report this immediately to your vendor! ** [ 0.177017] ** ** [ 0.179011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.182012] ************************************************************* [ 0.185789] NET: Registered protocol family 16 [ 0.187438] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.191057] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.194057] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.201010] cpuidle: using governor menu [ 0.203712] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.207816] PCI: Using configuration type 1 for base access [ 0.208120] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.218108] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.220173] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.224071] cryptd: max_cpu_qlen set to 1000 [ 0.226300] ACPI: Added _OSI(Module Device) [ 0.228019] ACPI: Added _OSI(Processor Device) [ 0.230117] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.232015] ACPI: Added _OSI(Processor Aggregator Device) [ 0.238130] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.246106] ACPI: Interpreter enabled [ 0.247000] ACPI: PM: (supports S0 S3 S4 S5) [ 0.249016] ACPI: Using IOAPIC for interrupt routing [ 0.253098] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.256443] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.265600] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.268084] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.270017] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.273068] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.278508] acpiphp: Slot [2] registered [ 0.279000] acpiphp: Slot [5] registered [ 0.279000] acpiphp: Slot [6] registered [ 0.280112] acpiphp: Slot [3] registered [ 0.282098] acpiphp: Slot [4] registered [ 0.284195] acpiphp: Slot [7] registered [ 0.285195] acpiphp: Slot [8] registered [ 0.287153] acpiphp: Slot [9] registered [ 0.289099] acpiphp: Slot [10] registered [ 0.290174] acpiphp: Slot [11] registered [ 0.293273] acpiphp: Slot [12] registered [ 0.295098] acpiphp: Slot [13] registered [ 0.298141] acpiphp: Slot [14] registered [ 0.300168] acpiphp: Slot [15] registered [ 0.302188] acpiphp: Slot [16] registered [ 0.304111] acpiphp: Slot [17] registered [ 0.306161] acpiphp: Slot [18] registered [ 0.308100] acpiphp: Slot [19] registered [ 0.310243] acpiphp: Slot [20] registered [ 0.316121] acpiphp: Slot [21] registered [ 0.317098] acpiphp: Slot [22] registered [ 0.319101] acpiphp: Slot [23] registered [ 0.321118] acpiphp: Slot [24] registered [ 0.323118] acpiphp: Slot [25] registered [ 0.326139] acpiphp: Slot [26] registered [ 0.329149] acpiphp: Slot [27] registered [ 0.331137] acpiphp: Slot [28] registered [ 0.332194] acpiphp: Slot [29] registered [ 0.334127] acpiphp: Slot [30] registered [ 0.336271] acpiphp: Slot [31] registered [ 0.337048] PCI host bridge to bus 0000:00 [ 0.339021] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.341021] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.346048] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.349022] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.352021] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.355030] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.357173] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.361092] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.365879] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.373013] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.378124] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.381017] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.384016] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.387034] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.389557] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.395148] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.400347] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.404178] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.411012] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.421994] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.428013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.433000] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.443013] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.450014] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.472000] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.489091] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.497062] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.507015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.533014] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.552056] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.554735] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.557408] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.560408] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.562276] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.568109] iommu: Default domain type: Passthrough [ 0.570409] SCSI subsystem initialized [ 0.572128] ACPI: bus type USB registered [ 0.573107] usbcore: registered new interface driver usbfs [ 0.575085] usbcore: registered new interface driver hub [ 0.577075] usbcore: registered new device driver usb [ 0.580176] pps_core: LinuxPPS API ver. 1 registered [ 0.584016] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.589058] PTP clock support registered [ 0.592102] EDAC MC: Ver: 3.0.0 [ 0.593383] PCI: Using ACPI for IRQ routing [ 0.595697] NetLabel: Initializing [ 0.596000] NetLabel: domain hash size = 128 [ 0.596000] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.600117] NetLabel: unlabeled traffic allowed by default [ 0.603004] vgaarb: loaded [ 0.604557] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.606010] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.612660] clocksource: Switched to clocksource kvm-clock [ 0.729976] VFS: Disk quotas dquot_6.6.0 [ 0.731574] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.736330] *** VALIDATE ramfs *** [ 0.737621] *** VALIDATE hugetlbfs *** [ 0.740118] pnp: PnP ACPI init [ 0.744179] pnp: PnP ACPI: found 6 devices [ 0.769152] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.774589] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.777146] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.779596] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.781831] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.783603] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.785730] NET: Registered protocol family 2 [ 0.787959] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.793109] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.796481] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.801122] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.803611] TCP: Hash tables configured (established 65536 bind 65536) [ 0.805814] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.809163] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.811160] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.813123] NET: Registered protocol family 1 [ 0.815721] RPC: Registered named UNIX socket transport module. [ 0.817628] RPC: Registered udp transport module. [ 0.818834] RPC: Registered tcp transport module. [ 0.819856] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.821432] NET: Registered protocol family 44 [ 0.822894] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.824513] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.826539] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.829634] PCI: CLS 0 bytes, default 64 [ 0.831993] Unpacking initramfs... [ 2.362875] debug: unmapping init [mem 0xffff98473cc64000-0xffff98473ffcffff] [ 2.367371] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.369946] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.373304] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.885982] Initialise system trusted keyrings [ 2.887807] Key type blacklist registered [ 2.889789] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.906331] zbud: loaded [ 2.910663] *** VALIDATE nfs *** [ 2.912339] *** VALIDATE nfs4 *** [ 2.914906] pstore: using deflate compression [ 2.919036] Platform Keyring initialized [ 3.033160] NET: Registered protocol family 38 [ 3.034600] Key type asymmetric registered [ 3.035958] Asymmetric key parser 'x509' registered [ 3.037691] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.042866] io scheduler mq-deadline registered [ 3.045195] io scheduler kyber registered [ 3.047355] io scheduler bfq registered [ 3.050552] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.053931] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.056825] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.059580] ACPI: Power Button [PWRF] [ 3.065237] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.071323] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.081510] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.116330] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.148108] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.155481] Non-volatile memory driver v1.3 [ 3.157844] Linux agpgart interface v0.103 [ 3.189404] virtio_blk virtio1: [vda] 145896 512-byte logical blocks (74.7 MB/71.2 MiB) [ 3.192824] vda: detected capacity change from 0 to 74698752 [ 3.211769] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.214549] vdb: detected capacity change from 0 to 1073741824 [ 3.223484] libphy: Fixed MDIO Bus: probed [ 3.231969] usbcore: registered new interface driver usbserial_generic [ 3.234725] usbserial: USB Serial support registered for generic [ 3.236721] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.241207] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.242527] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.245682] mousedev: PS/2 mouse device common for all mice [ 3.249850] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.252440] rtc_cmos 00:05: RTC can wake from S4 [ 3.259441] rtc_cmos 00:05: registered as rtc0 [ 3.261467] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.264359] intel_pstate: CPU model not supported [ 3.267720] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.269314] hid: raw HID events driver (C) Jiri Kosina [ 3.273266] usbcore: registered new interface driver usbhid [ 3.275136] usbhid: USB HID core driver [ 3.276668] drop_monitor: Initializing network drop monitor service [ 3.276980] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.279611] Initializing XFRM netlink socket [ 3.285561] NET: Registered protocol family 10 [ 3.288476] Segment Routing with IPv6 [ 3.290158] NET: Registered protocol family 17 [ 3.292053] mpls_gso: MPLS GSO support [ 3.297425] RAS: Correctable Errors collector initialized. [ 3.299596] AVX version of gcm_enc/dec engaged. [ 3.303016] AES CTR mode by8 optimization enabled [ 3.380838] sched_clock: Marking stable (3380777631, 0)->(4366166909, -985389278) [ 3.384734] registered taskstats version 1 [ 3.387342] Loading compiled-in X.509 certificates [ 3.389726] zswap: loaded using pool lzo/zbud [ 3.422286] Key type big_key registered [ 3.436063] Key type encrypted registered [ 3.438326] ima: No TPM chip found, activating TPM-bypass! [ 3.441088] ima: Allocated hash algorithm: sha1 [ 3.442965] ima: No architecture policies found [ 3.445714] evm: Initialising EVM extended attributes: [ 3.448326] evm: security.selinux [ 3.450661] evm: security.ima [ 3.452510] evm: security.capability [ 3.454682] evm: HMAC attrs: 0x1 [ 3.457293] rtc_cmos 00:05: setting system clock to 2026-08-14 21:42:22 UTC (1786743742) [ 3.464136] debug: unmapping init [mem 0xffffffffaa203000-0xffffffffaa3fffff] [ 3.467448] debug: unmapping init [mem 0xffffffffa8f82000-0xffffffffa9258fff] [ 3.477071] Write protecting the kernel read-only data: 28672k [ 3.483827] debug: unmapping init [mem 0xffffffffa7603000-0xffffffffa77fffff] [ 3.488269] debug: unmapping init [mem 0xffffffffa7f14000-0xffffffffa7ffffff] [ 3.533455] 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.544395] systemd[1]: Detected virtualization kvm. [ 3.546529] systemd[1]: Detected architecture x86-64. [ 3.548791] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.577979] systemd[1]: No hostname configured. [ 3.581272] systemd[1]: Set hostname to . [ 3.583394] random: systemd: uninitialized urandom read (16 bytes read) [ 3.586725] systemd[1]: Initializing machine ID from random generator. [ 3.665611] random: ln: uninitialized urandom read (6 bytes read) [ 3.785517] random: systemd: uninitialized urandom read (16 bytes read) [ 3.788779] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 3.794125] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ 3.798515] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Listening on udev Control Socket. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Slices. Starting Apply Kernel Variables... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Sockets. [ OK ] Reached target Swap. 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.611917] device-mapper: uevent: version 1.0.3 [ 4.618672] 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.652698] virtio_net virtio0 ens2: renamed from eth0 [ 5.662456] random: fast init done [ 5.816887] scsi host0: ata_piix [ 5.849395] scsi host1: ata_piix [ 5.850744] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.853703] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 10.168569] dracut-initqueue[586]: RTNETLINK answers: File exists [ 10.962908] random: crng init done [ 10.965359] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 11.689417] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ 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... [ 13.126550] printk: systemd: 26 output lines suppressed due to ratelimiting [ 13.399898] SELinux: Disabled at runtime. [ 13.461596] 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) [ 13.471821] systemd[1]: Detected virtualization kvm. [ 13.474037] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 14.083453] systemd[1]: initrd-switch-root.service: Succeeded. [ 14.086916] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 14.091082] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 14.098213] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 14.102371] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 14.116953] systemd[1]: Starting Journal Service... Starting Journal Service... [ 14.121159] systemd[1]: Listening on initctl Compatibility Named Pipe. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Created slice User and Session Slice. Starting Remount Root and Kernel File Systems... Mounting POSIX Message Queue File System... [ OK ] Listening on RPCbind Server Activation Socket. Activating swap /dev/disk/by-label/SWAP... [ OK ] Reached target rpc_pipefs.target. Mounting Huge Pages File System... [ 14.244516] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Reached target RPC Port Mapper. [ OK ] Stopped target Switch Root. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Slices. [ OK ] Created slice system-getty.slice. [ OK ] Stopped target Initrd Root File System. Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Stopped target Initrd File Systems. Mounting Kernel Debug File System... [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Huge Pages File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Mounted Kernel Debug File System. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started udev Coldplug all Devices. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 14.787686] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 15.135220] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 15.201324] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 15.322873] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 15.343650] EDAC sbridge: Ver: 1.1.2 [ 16.664392] Key type dns_resolver registered [ 17.028644] NFS: Registering the id_resolver key type [ 17.030219] Key type id_resolver registered [ 17.031548] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started dnf makecache --timer. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting 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... Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ 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. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg651-client login: [ 63.800031] libcfs: loading out-of-tree module taints kernel. [ 64.123337] Key type ._llcrypt registered [ 64.125149] Key type .llcrypt registered [ 64.446391] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 64.467822] alg: No test for adler32 (adler32-zlib) [ 65.528542] hrtimer: interrupt took 4533594 ns [ 65.745861] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 66.428676] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 68.191130] Key type lgssc registered [ 71.440289] Lustre: Echo OBD driver; http://www.lustre.org/ [ 240.430688] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 245.562409] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 257.962610] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing check_logdir /tmp/testlogs/ [ 262.206719] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing yml_node [ 266.207236] Lustre: lustre-OST0000-osc-ffff98478635c800: disconnect after 24s idle [ 266.752130] Lustre: DEBUG MARKER: Client: 2.17.57.1 [ 269.924941] Lustre: DEBUG MARKER: MDS: 2.17.57.1 [ 273.058846] Lustre: DEBUG MARKER: OSS: 2.17.57.1 [ 275.511651] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Aug 14 17:46:52 EDT 2026 [ 294.855601] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 296.503196] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 299.701652] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 310.064259] Lustre: Unmounted lustre-client [ 419.699981] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 425.597479] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 452.702490] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 498.300061] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 17:50:35 (1786744235) [ 501.099811] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 502.846742] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 17:50:40 (1786744240) [ 539.849665] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 545.797773] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 568.693520] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 569.455427] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 577.426258] Lustre: Unmounted lustre-client [ 615.094085] Key type lgssc unregistered [ 615.547958] LNet: 15042:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 615.559069] LNetError: 15042:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 615.579602] LNet: Removed LNI 192.168.206.51@tcp [ 616.940109] Key type .llcrypt unregistered [ 616.951707] Key type ._llcrypt unregistered [ 635.531369] Key type ._llcrypt registered [ 635.543871] Key type .llcrypt registered [ 636.975768] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 17:52:54 (1786744374) [ 638.491197] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 638.524642] alg: No test for adler32 (adler32-zlib) [ 639.810601] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 640.171240] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 641.831374] Key type lgssc registered [ 643.337867] Lustre: Echo OBD driver; http://www.lustre.org/ [ 726.183334] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 814.777644] Lustre: Unmounted lustre-client [ 845.634541] Key type lgssc unregistered [ 845.892950] LNet: 18893:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 845.898132] LNetError: 18893:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 845.930353] LNet: Removed LNI 192.168.206.51@tcp [ 846.713387] Key type .llcrypt unregistered [ 846.719630] Key type ._llcrypt unregistered [ 858.168335] Key type ._llcrypt registered [ 858.170629] Key type .llcrypt registered [ 859.740859] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 17:56:37 (1786744597) [ 862.640306] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 862.837235] alg: No test for adler32 (adler32-zlib) [ 863.975916] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 864.269124] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 865.967447] Key type lgssc registered [ 867.202597] Lustre: Echo OBD driver; http://www.lustre.org/ [ 918.958505] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 925.015326] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 946.415673] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 947.982742] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 962.122212] Lustre: Unmounted lustre-client [ 990.076168] Key type lgssc unregistered [ 990.374579] LNet: 22495:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 990.391163] LNetError: 22495:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 990.411645] LNet: Removed LNI 192.168.206.51@tcp [ 991.251268] Key type .llcrypt unregistered [ 991.253251] Key type ._llcrypt unregistered [ 1001.822045] Key type ._llcrypt registered [ 1001.826156] Key type .llcrypt registered [ 1003.002995] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 17:59:00 (1786744740) [ 1005.641830] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1005.659623] alg: No test for adler32 (adler32-zlib) [ 1006.723628] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 1007.030142] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1008.727197] Key type lgssc registered [ 1009.798491] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1058.987969] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1065.766396] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1087.375375] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1089.285985] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 1099.029619] Lustre: Unmounted lustre-client [ 1138.075917] Key type lgssc unregistered [ 1138.343292] LNet: 25704:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1138.350957] LNetError: 25704:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1138.391056] LNet: Removed LNI 192.168.206.51@tcp [ 1139.056494] Key type .llcrypt unregistered [ 1139.063368] Key type ._llcrypt unregistered [ 1155.554222] Key type ._llcrypt registered [ 1155.555944] Key type .llcrypt registered [ 1157.164275] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 18:01:34 (1786744894) [ 1159.830051] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1159.956880] alg: No test for adler32 (adler32-zlib) [ 1161.276365] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 1161.662261] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1163.504237] Key type lgssc registered [ 1165.632187] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1219.639631] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1226.000672] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1247.826001] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1249.689527] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 1260.041925] Lustre: lustre-MDT0000-mdc-ffff984788572800: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1270.250127] Lustre: lustre-MDT0001-mdc-ffff984788572800: Connection to lustre-MDT0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1276.408359] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1281.503167] Lustre: 26664:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786745004/real 1786745004] req@00000000f9a13d83 x1873537820268544/t0(0) o400->MGC192.168.206.151@tcp@192.168.206.151@tcp:26/25 lens 224/224 e 0 to 1 dl 1786745020 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1281.538146] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 1286.755692] Lustre: Unmounted lustre-client [ 1300.298752] Key type lgssc unregistered [ 1300.532621] LNet: 29366:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1300.541704] LNetError: 29366:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1300.577089] LNet: Removed LNI 192.168.206.51@tcp [ 1301.233758] Key type .llcrypt unregistered [ 1301.235656] Key type ._llcrypt unregistered [ 1316.139532] Key type ._llcrypt registered [ 1316.141179] Key type .llcrypt registered [ 1317.714696] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 18:04:15 (1786745055) [ 1320.290072] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1320.331575] alg: No test for adler32 (adler32-zlib) [ 1321.463373] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 1321.735568] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1323.431636] Key type lgssc registered [ 1324.866475] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1374.619819] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1380.903730] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1402.426672] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1404.151956] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 1415.054724] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1425.420470] Lustre: Unmounted lustre-client [ 1453.804252] Key type lgssc unregistered [ 1454.066567] LNet: 32981:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1454.085635] LNetError: 32981:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1455.141269] LNet: Removed LNI 192.168.206.51@tcp [ 1455.901822] Key type .llcrypt unregistered [ 1455.909248] Key type ._llcrypt unregistered [ 1471.870602] Key type ._llcrypt registered [ 1471.874021] Key type .llcrypt registered [ 1473.362823] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 18:06:50 (1786745210) [ 1475.779721] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1475.810577] alg: No test for adler32 (adler32-zlib) [ 1476.949574] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 1477.281528] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1478.960463] Key type lgssc registered [ 1480.329113] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1530.807325] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1536.137565] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1557.028477] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1559.659269] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 1562.952971] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1566.243823] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1577.806826] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-1418h08m35s [ 1580.022861] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1585.140836] Lustre: lustre-MDT0000-mdc-ffff98478637d000: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1599.493499] LustreError: 36774:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff98478637d000: can't stat MDS #0: rc = -19 [ 1601.834669] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1609.708352] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 1609.730636] LustreError: lustre-MDT0000-mdc-ffff98478637d000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1609.747795] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0x763210638a140016 to 0x763210638a1402c4 [ 1609.763075] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 1609.769936] Lustre: Skipped 1 previous similar message [ 1617.013371] Lustre: DEBUG MARKER: Wait for df (36774) ... [ 1618.593722] Lustre: DEBUG MARKER: done [ 1621.446318] Lustre: Unmounted lustre-client [ 1649.034346] Key type lgssc unregistered [ 1649.296176] LNet: 37793:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1649.300778] LNetError: 37793:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1649.313297] LNet: Removed LNI 192.168.206.51@tcp [ 1649.979253] Key type .llcrypt unregistered [ 1649.982148] Key type ._llcrypt unregistered [ 1680.342064] Key type ._llcrypt registered [ 1680.344519] Key type .llcrypt registered [ 1681.952555] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 18:10:19 (1786745419) [ 1684.638538] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1684.700960] alg: No test for adler32 (adler32-zlib) [ 1685.807783] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 1686.086062] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1687.815161] Key type lgssc registered [ 1689.047799] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1744.447896] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1751.974777] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1773.185116] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1775.637049] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 1781.021208] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-1418h11m57s [ 1782.904864] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1791.025879] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1793.680954] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1813.983206] Lustre: 41939:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786745532/real 1786745532] req@0000000001f97d75 x1873538370771584/t0(0) o101->lustre-MDT0000-mdc-ffff98479042c000@192.168.206.151@tcp:12/10 lens 576/1152 e 0 to 1 dl 1786745552 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1814.024444] Lustre: lustre-MDT0000-mdc-ffff98479042c000: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1814.057109] Lustre: lustre-MDT0000-mdc-ffff98479042c000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 1836.446367] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1839.836318] Lustre: DEBUG MARKER: done [ 1843.673507] Lustre: Unmounted lustre-client [ 1871.319842] Key type lgssc unregistered [ 1871.593905] LNet: 42829:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1871.606706] LNetError: 42829:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1871.637857] LNet: Removed LNI 192.168.206.51@tcp [ 1872.233454] Key type .llcrypt unregistered [ 1872.236715] Key type ._llcrypt unregistered [ 1906.878895] Key type ._llcrypt registered [ 1906.885133] Key type .llcrypt registered [ 1908.712230] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 18:14:05 (1786745645) [ 1910.255267] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1912.176644] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 18:14:09 (1786745649) [ 1915.960144] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1915.991586] alg: No test for adler32 (adler32-zlib) [ 1917.084747] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 1917.332623] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1918.999556] Key type lgssc registered [ 1920.522775] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1954.601462] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 18:14:52 (1786745692) [ 1991.393332] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1998.397519] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2024.131944] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2026.176158] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 2030.704096] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2035.060245] Lustre: Unmounted lustre-client [ 2053.568058] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2103.551922] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2109.445716] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2110.095954] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 2113.881146] Lustre: Unmounted lustre-client [ 2172.731849] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2178.694890] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2179.489433] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 2183.680310] Lustre: Unmounted lustre-client [ 2206.237705] Lustre: DEBUG MARKER: files compared the same [ 2229.059617] Key type lgssc unregistered [ 2229.372717] LNet: 50463:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2229.388745] LNetError: 50463:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2229.413388] LNet: Removed LNI 192.168.206.51@tcp [ 2230.187751] Key type .llcrypt unregistered [ 2230.189819] Key type ._llcrypt unregistered [ 2245.158615] Key type ._llcrypt registered [ 2245.164167] Key type .llcrypt registered [ 2246.638692] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 18:19:43 (1786745983) [ 2249.440916] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2249.541595] alg: No test for adler32 (adler32-zlib) [ 2250.675529] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 2250.897443] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 2252.687239] Key type lgssc registered [ 2254.071584] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2311.499893] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2317.456127] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2337.915687] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2339.556446] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 2347.555227] Lustre: Unmounted lustre-client [ 2372.660581] Key type lgssc unregistered [ 2373.214956] LNet: 54052:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2373.236866] LNetError: 54052:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2373.268757] LNet: Removed LNI 192.168.206.51@tcp [ 2374.248956] Key type .llcrypt unregistered [ 2374.254140] Key type ._llcrypt unregistered [ 2391.355203] Key type ._llcrypt registered [ 2391.357339] Key type .llcrypt registered [ 2392.971265] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 18:22:10 (1786746130) [ 2395.256963] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2395.324966] alg: No test for adler32 (adler32-zlib) [ 2396.467775] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 2396.742796] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 2398.415133] Key type lgssc registered [ 2399.671427] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2485.091613] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2518.920707] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2524.582159] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2561.896893] Key type lgssc unregistered [ 2562.166586] LNet: 57545:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2562.177986] LNetError: 57545:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2562.202769] LNet: Removed LNI 192.168.206.51@tcp [ 2563.312775] Key type .llcrypt unregistered [ 2563.317439] Key type ._llcrypt unregistered [ 2579.342407] Key type ._llcrypt registered [ 2579.344586] Key type .llcrypt registered [ 2580.393986] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 18:25:18 (1786746318) [ 2583.747776] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2583.775941] alg: No test for adler32 (adler32-zlib) [ 2585.001230] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 2585.282413] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 2586.991204] Key type lgssc registered [ 2588.147397] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2662.093238] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 2670.637514] Lustre: Unmounted lustre-client [ 2708.625711] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 18:27:26 (1786746446) [ 2826.986180] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2847.283706] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 2854.780832] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2854.794696] LustreError: 64024:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff984799b8c800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2854.822815] Lustre: 58531:0:(llite_lib.c:4340:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.151@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2865.229218] Lustre: Unmounted lustre-client [ 2909.801750] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 18:30:47 (1786746647) [ 2922.571510] Key type lgssc unregistered [ 2922.808780] LNet: 65240:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2922.816322] LNetError: 65240:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2922.833136] LNet: Removed LNI 192.168.206.51@tcp [ 2923.453183] Key type .llcrypt unregistered [ 2923.456358] Key type ._llcrypt unregistered [ 2934.380523] Key type ._llcrypt registered [ 2934.382162] Key type .llcrypt registered [ 2934.780171] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2934.797442] alg: No test for adler32 (adler32-zlib) [ 2935.906378] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 2936.190948] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 2937.855221] Key type lgssc registered [ 2939.038978] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2984.589395] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2989.643509] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3005.556551] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3011.629779] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 3015.155667] Lustre: Unmounted lustre-client [ 3040.566038] Key type lgssc unregistered [ 3040.805254] LNet: 68257:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3040.815810] LNetError: 68257:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3040.848487] LNet: Removed LNI 192.168.206.51@tcp [ 3041.442479] Key type .llcrypt unregistered [ 3041.444911] Key type ._llcrypt unregistered [ 3050.216087] Key type ._llcrypt registered [ 3050.217918] Key type .llcrypt registered [ 3050.700863] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3050.728070] alg: No test for adler32 (adler32-zlib) [ 3051.731251] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 3052.014626] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3053.687197] Key type lgssc registered [ 3054.776120] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3160.249638] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3166.716696] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3190.925801] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3192.745306] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 3200.785942] Lustre: Unmounted lustre-client [ 3228.946871] Key type lgssc unregistered [ 3229.224136] LNet: 71694:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3229.232301] LNetError: 71694:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3229.264087] LNet: Removed LNI 192.168.206.51@tcp [ 3230.116647] Key type .llcrypt unregistered [ 3230.118192] Key type ._llcrypt unregistered [ 3245.263218] Key type ._llcrypt registered [ 3245.269766] Key type .llcrypt registered [ 3246.605585] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 18:36:24 (1786746984) [ 3248.926945] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3248.956342] alg: No test for adler32 (adler32-zlib) [ 3250.150269] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 3250.379502] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3252.120394] Key type lgssc registered [ 3253.128488] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3303.777225] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3310.638288] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3333.825617] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3335.722281] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 3344.303717] Lustre: Unmounted lustre-client [ 3344.796114] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 3348.236406] Lustre: Unmounted lustre-client [ 3371.588552] Key type lgssc unregistered [ 3371.872667] LNet: 75384:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3371.881273] LNetError: 75384:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3371.901922] LNet: Removed LNI 192.168.206.51@tcp [ 3372.640220] Key type .llcrypt unregistered [ 3372.644434] Key type ._llcrypt unregistered [ 3383.192582] Key type ._llcrypt registered [ 3383.197156] Key type .llcrypt registered [ 3383.818246] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3383.847161] alg: No test for adler32 (adler32-zlib) [ 3384.953410] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 3385.249510] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3386.946333] Key type lgssc registered [ 3388.181747] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3431.504228] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3436.860481] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3456.228949] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3457.971295] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 3461.808660] Lustre: Unmounted lustre-client [ 3495.828813] Key type lgssc unregistered [ 3496.175457] LNet: 78420:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3496.188440] LNetError: 78420:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3496.221848] LNet: Removed LNI 192.168.206.51@tcp [ 3496.996371] Key type .llcrypt unregistered [ 3497.002354] Key type ._llcrypt unregistered [ 3512.645241] Key type ._llcrypt registered [ 3512.648405] Key type .llcrypt registered [ 3513.943914] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 18:40:51 (1786747251) [ 3516.516552] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3516.529947] alg: No test for adler32 (adler32-zlib) [ 3517.566296] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 3517.960582] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3519.615381] Key type lgssc registered [ 3521.119868] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3564.875646] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3569.757559] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3588.279296] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3590.772183] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 3596.783982] Lustre: lustre: root_squash is set to 0:0 [ 3606.564804] Lustre: lustre: nosquash_nids is cleared [ 3606.590179] Lustre: lustre: root_squash is set to 500:500 [ 3612.359141] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.51@tcp 192.168.0.[2,10]@tcp [ 3628.576702] Lustre: lustre: nosquash_nids set to 192.168.206.51/24@tcp [ 3631.182755] Lustre: Unmounted lustre-client [ 3657.270290] Key type lgssc unregistered [ 3657.651708] LNet: 82393:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3657.659850] LNetError: 82393:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3657.676164] LNet: Removed LNI 192.168.206.51@tcp [ 3658.378228] Key type .llcrypt unregistered [ 3658.381927] Key type ._llcrypt unregistered [ 3672.427347] Key type ._llcrypt registered [ 3672.430760] Key type .llcrypt registered [ 3673.539442] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 18:43:31 (1786747411) [ 3675.540415] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3676.982594] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 18:43:34 (1786747414) [ 3679.591480] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3679.627192] alg: No test for adler32 (adler32-zlib) [ 3680.601316] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 3680.794821] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3682.463263] Key type lgssc registered [ 3683.844935] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3726.716980] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3732.546476] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3750.322874] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3751.758400] Lustre: lustre: root_squash is set to 500:500 [ 3751.791265] Lustre: lustre: nosquash_nids set to 192.168.206.51/24@tcp [ 3752.850359] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 3757.725428] Lustre: Unmounted lustre-client [ 3782.574811] Key type lgssc unregistered [ 3782.787824] LNet: 86365:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3782.798226] LNetError: 86365:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3782.820203] LNet: Removed LNI 192.168.206.51@tcp [ 3783.494351] Key type .llcrypt unregistered [ 3783.496735] Key type ._llcrypt unregistered [ 3795.710088] Key type ._llcrypt registered [ 3795.712774] Key type .llcrypt registered [ 3796.845237] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3798.222412] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 18:45:36 (1786747536) [ 3813.046743] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3813.125813] alg: No test for adler32 (adler32-zlib) [ 3814.162328] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 3814.383239] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3816.055525] Key type lgssc registered [ 3817.193672] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3885.541109] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3889.806206] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3908.334808] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3968.947669] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3973.772876] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3991.422978] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4002.441097] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 4031.516162] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff98478635e800.ost_server_uuid 50 [ 4032.932991] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff98478635e800.ost_server_uuid in FULL state after 0 sec [ 4033.294537] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 4036.354611] Lustre: Unmounted lustre-client [ 4037.839144] Lustre: Unmounted lustre-client [ 4079.999812] Key type lgssc unregistered [ 4080.328661] LNet: 94031:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4080.334240] LNetError: 94031:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4080.352892] LNet: Removed LNI 192.168.206.51@tcp [ 4081.105057] Key type .llcrypt unregistered [ 4081.108104] Key type ._llcrypt unregistered [ 4108.758539] Key type ._llcrypt registered [ 4108.760485] Key type .llcrypt registered [ 4110.163085] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 18:50:47 (1786747847) [ 4129.811508] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4129.861600] alg: No test for adler32 (adler32-zlib) [ 4131.157790] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 4131.497119] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 4133.159253] Key type lgssc registered [ 4134.252879] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4209.715302] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4215.274584] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4235.818701] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4238.495558] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 4259.295177] Lustre: 95400:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786747982/real 1786747982] req@0000000091209272 x1873540934538496/t0(0) o400->lustre-OST0000-osc-ffff9847862a8000@192.168.206.151@tcp:28/4 lens 224/224 e 0 to 1 dl 1786747998 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4259.319551] Lustre: lustre-OST0000-osc-ffff9847862a8000: Connection to lustre-OST0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4259.526427] Lustre: lustre-OST0000-osc-ffff9847862a8000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 4265.439646] Lustre: 95400:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786747988/real 1786747988] req@000000007f1b78a1 x1873540934539008/t0(0) o400->lustre-OST0000-osc-ffff9847862a8000@192.168.206.151@tcp:28/4 lens 224/224 e 0 to 1 dl 1786748004 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4269.562382] Lustre: lustre-MDT0000-mdc-ffff9847862a8000: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4270.625500] Lustre: 95399:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786747993/real 1786747993] req@00000000aac1f42e x1873540934539520/t0(0) o400->lustre-OST0000-osc-ffff9847862a8000@192.168.206.151@tcp:28/4 lens 224/224 e 0 to 1 dl 1786748009 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4285.919358] Lustre: 95402:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786748008/real 1786748008] req@000000009e24b577 x1873540934541440/t0(0) o400->MGC192.168.206.151@tcp@192.168.206.151@tcp:26/25 lens 224/224 e 0 to 1 dl 1786748024 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4285.942290] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 4296.186643] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0xc7ce929cd28c6d3f to 0xc7ce929cd28c7017 [ 4296.199306] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 4301.455900] Lustre: lustre-MDT0000-mdc-ffff9847862a8000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 4304.950785] Lustre: Unmounted lustre-client [ 4331.001317] Key type lgssc unregistered [ 4331.288667] LNet: 99704:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4331.297231] LNetError: 99704:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4331.315465] LNet: Removed LNI 192.168.206.51@tcp [ 4332.131325] Key type .llcrypt unregistered [ 4332.133363] Key type ._llcrypt unregistered [ 4345.889984] Key type ._llcrypt registered [ 4345.891862] Key type .llcrypt registered [ 4347.174564] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 18:54:44 (1786748084) [ 4361.531510] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4361.551728] alg: No test for adler32 (adler32-zlib) [ 4362.568877] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 4362.808311] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 4364.492516] Key type lgssc registered [ 4365.524625] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4400.702115] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4497.983293] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4504.531251] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4525.291781] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4526.820695] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 4528.439274] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4530.003607] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 18:57:47 (1786748267) [ 4761.791879] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4772.133545] Lustre: Unmounted lustre-client [ 4892.122706] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4898.272658] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4921.886933] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4962.989798] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:05:00 (1786748700) [ 5061.398395] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5067.786867] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5090.371517] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5091.182415] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 5095.896389] Lustre: Unmounted lustre-client [ 5128.961518] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 19:07:46 (1786748866) [ 5233.185118] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5239.968270] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5268.308647] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5269.249470] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 5275.134922] Lustre: Unmounted lustre-client [ 5308.104048] Key type lgssc unregistered [ 5308.772354] LNet: 122746:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5308.780437] LNetError: 122746:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5308.807320] LNet: Removed LNI 192.168.206.51@tcp [ 5310.111628] Key type .llcrypt unregistered [ 5310.114628] Key type ._llcrypt unregistered [ 5331.477242] Key type ._llcrypt registered [ 5331.479139] Key type .llcrypt registered [ 5333.090281] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 19:11:10 (1786749070) [ 5335.502051] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5335.524518] alg: No test for adler32 (adler32-zlib) [ 5336.605159] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 5336.802570] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 5338.463191] Key type lgssc registered [ 5340.137714] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5395.839460] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5401.163760] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5423.103855] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5424.781954] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 5438.281934] Lustre: Unmounted lustre-client [ 5466.049576] Key type lgssc unregistered [ 5466.299426] LNet: 126344:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5466.311705] LNetError: 126344:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5466.335449] LNet: Removed LNI 192.168.206.51@tcp [ 5467.102280] Key type .llcrypt unregistered [ 5467.107315] Key type ._llcrypt unregistered [ 5482.128290] Key type ._llcrypt registered [ 5482.135648] Key type .llcrypt registered [ 5483.592204] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 19:13:41 (1786749221) [ 5486.891358] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5486.912604] alg: No test for adler32 (adler32-zlib) [ 5488.147081] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 5488.395921] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 5490.047186] Key type lgssc registered [ 5491.477459] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5547.751174] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5554.194165] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5575.299680] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5577.501188] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 5582.823628] Lustre: lustre-OST0000-osc-ffff9847859b3800: Connection to lustre-OST0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5598.531972] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff9847859b3800.ost_server_uuid 50 [ 5600.767485] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5611.679852] Lustre: Unmounted lustre-client [ 5634.670343] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 19:16:12 (1786749372) [ 5668.327940] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5674.516869] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5700.880319] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5731.875782] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5732.707140] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 5737.988865] Lustre: lustre-OST0000-osc-ffff984785bbe800: Connection to lustre-OST0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5763.579274] Lustre: Unmounted lustre-client [ 5810.964992] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 19:19:08 (1786749548) [ 5845.700801] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5851.582066] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5875.495079] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5900.456444] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5901.115284] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 5906.416182] Lustre: lustre-OST0000-osc-ffff98478877b000: Connection to lustre-OST0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5922.950128] Lustre: Unmounted lustre-client [ 5969.661186] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 19:21:47 (1786749707) [ 6064.725828] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6073.487954] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6100.183575] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6175.723525] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6181.773539] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6203.835789] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6234.766918] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 6278.064536] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6280.810085] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 1 sec [ 6283.259714] Lustre: Unmounted lustre-client [ 6322.541952] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 19:27:40 (1786750060) [ 6358.480810] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6365.956315] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6390.132397] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6426.159836] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6460.137159] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 6509.866298] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6511.688982] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6525.297726] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6535.692177] Lustre: Unmounted lustre-client [ 6598.823809] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 19:32:16 (1786750336) [ 6631.377801] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6637.601552] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6660.344521] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6661.200980] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 6682.137270] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6683.737642] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6698.229534] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff98479098f000.ost_server_uuid 50 [ 6699.891890] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff98479098f000.ost_server_uuid in IDLE state after 0 sec [ 6703.542097] Lustre: Unmounted lustre-client [ 6703.880939] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6703.887918] Lustre: Skipped 3 previous similar messages [ 6704.064077] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 6705.586939] LustreError: 149801:0:(sec.c:403:import_sec_validate_get()) import 00000000a25a5bd7 (NEW) with no sec [ 6767.553924] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 19:35:04 (1786750504) [ 6806.049923] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6812.439868] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6834.333162] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6857.261085] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6857.855741] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6858.130464] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 6872.187708] LustreError: 152771:0:(ldlm_resource.c:1207:ldlm_resource_complain()) lustre-OST0001-osc-ffff9847853c5800: namespace resource [0x2c0000400:0x42:0x0].0x0 (00000000e997b370) refcount nonzero (1) after lock cleanup; forcing cleanup. [ 6872.335660] Lustre: Unmounted lustre-client [ 6872.342025] Lustre: Skipped 1 previous similar message [ 6912.703392] Key type lgssc unregistered [ 6913.084714] LNet: 153223:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6913.092847] LNetError: 153223:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6913.129579] LNet: Removed LNI 192.168.206.51@tcp [ 6913.952123] Key type .llcrypt unregistered [ 6913.953747] Key type ._llcrypt unregistered [ 6933.605997] Key type ._llcrypt registered [ 6933.608065] Key type .llcrypt registered [ 6935.180659] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 19:37:52 (1786750672) [ 6936.550479] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6936.563729] alg: No test for adler32 (adler32-zlib) [ 6937.627059] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 6937.885627] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 6939.567192] Key type lgssc registered [ 6940.900807] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6998.536897] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7005.759423] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7030.388934] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7053.189674] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7053.631818] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7054.787666] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 7061.012048] LustreError: lustre-MDT0001-mdc-ffff9847887cd800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7061.038428] Lustre: lustre-MDT0001-mdc-ffff9847887cd800: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 7067.639266] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7069.625236] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7089.184861] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7099.182974] Lustre: Unmounted lustre-client [ 7131.044859] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 19:41:08 (1786750868) [ 7231.193137] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7236.257851] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7259.291435] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7259.983838] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 7288.627701] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7290.400503] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7292.398127] Lustre: lustre-OST0001-osc-ffff984788571000: Connection to lustre-OST0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7302.306909] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7312.707460] Lustre: Unmounted lustre-client [ 7347.113494] Key type lgssc unregistered [ 7347.350920] LNet: 162844:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7347.356056] LNetError: 162844:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7347.369505] LNet: Removed LNI 192.168.206.51@tcp [ 7348.052865] Key type .llcrypt unregistered [ 7348.054833] Key type ._llcrypt unregistered [ 7380.044785] Key type ._llcrypt registered [ 7380.048256] Key type .llcrypt registered [ 7381.418844] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 19:45:18 (1786751118) [ 7384.073861] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7384.128148] alg: No test for adler32 (adler32-zlib) [ 7385.265891] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 7385.511192] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 7387.215149] Key type lgssc registered [ 7388.400623] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7437.828642] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7443.795866] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7463.620441] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7466.278205] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 7511.969113] Lustre: Unmounted lustre-client [ 7553.688276] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7554.470319] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 7590.250726] Lustre: Unmounted lustre-client [ 7618.945543] Key type lgssc unregistered [ 7619.241299] LNet: 167302:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7619.251281] LNetError: 167302:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7619.273321] LNet: Removed LNI 192.168.206.51@tcp [ 7620.017968] Key type .llcrypt unregistered [ 7620.024156] Key type ._llcrypt unregistered [ 7639.278441] Key type ._llcrypt registered [ 7639.284337] Key type .llcrypt registered [ 7640.728864] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 19:49:38 (1786751378) [ 7643.605200] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7643.660728] alg: No test for adler32 (adler32-zlib) [ 7644.734579] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 7644.983469] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 7646.720109] Key type lgssc registered [ 7647.791208] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7701.896451] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7709.358994] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7735.985263] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7739.063179] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 7761.148686] Lustre: Unmounted lustre-client [ 7790.141632] Key type lgssc unregistered [ 7790.436933] LNet: 171065:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7790.442538] LNetError: 171065:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7790.465375] LNet: Removed LNI 192.168.206.51@tcp [ 7791.207540] Key type .llcrypt unregistered [ 7791.209302] Key type ._llcrypt unregistered [ 7803.520619] Key type ._llcrypt registered [ 7803.525818] Key type .llcrypt registered [ 7803.888476] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7803.901773] alg: No test for adler32 (adler32-zlib) [ 7805.062591] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 7805.291682] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 7806.967803] Key type lgssc registered [ 7808.615416] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7856.777304] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7862.288738] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7880.005862] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7882.718216] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 7890.106668] Lustre: Unmounted lustre-client [ 7916.519085] Key type lgssc unregistered [ 7916.806909] LNet: 174133:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7916.817258] LNetError: 174133:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7916.833182] LNet: Removed LNI 192.168.206.51@tcp [ 7917.394176] Key type .llcrypt unregistered [ 7917.398878] Key type ._llcrypt unregistered [ 7932.781564] Key type ._llcrypt registered [ 7932.785911] Key type .llcrypt registered [ 7933.999854] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 19:54:31 (1786751671) [ 7936.243691] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7936.328391] alg: No test for adler32 (adler32-zlib) [ 7937.436629] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 7937.747930] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 7939.455167] Key type lgssc registered [ 7940.546512] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7986.769411] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7991.150563] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8009.878516] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8012.593862] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 8030.663666] Lustre: Unmounted lustre-client [ 8056.874901] Key type lgssc unregistered [ 8057.117249] LNet: 177888:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8057.124892] LNetError: 177888:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8057.144193] LNet: Removed LNI 192.168.206.51@tcp [ 8057.928966] Key type .llcrypt unregistered [ 8057.941378] Key type ._llcrypt unregistered [ 8071.403586] Key type ._llcrypt registered [ 8071.405455] Key type .llcrypt registered [ 8071.792146] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8071.815196] alg: No test for adler32 (adler32-zlib) [ 8073.023354] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 8073.265410] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8074.968042] Key type lgssc registered [ 8076.267069] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8126.169405] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8132.406460] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8154.136744] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8155.849408] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 8166.820883] Lustre: Unmounted lustre-client [ 8195.495894] Key type lgssc unregistered [ 8195.670683] LNet: 180957:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8195.673542] LNetError: 180957:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8195.680704] LNet: Removed LNI 192.168.206.51@tcp [ 8196.361872] Key type .llcrypt unregistered [ 8196.370669] Key type ._llcrypt unregistered [ 8213.970338] Key type ._llcrypt registered [ 8213.973316] Key type .llcrypt registered [ 8215.660485] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 19:59:12 (1786751952) [ 8240.074225] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8240.094749] alg: No test for adler32 (adler32-zlib) [ 8241.307167] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 8241.612181] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8243.359283] Key type lgssc registered [ 8245.026277] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8326.463193] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8332.585671] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8356.581491] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8397.995679] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 20:02:15 (1786752135) [ 8430.103826] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8434.946984] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8453.888329] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8455.477852] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 8460.857652] Lustre: Unmounted lustre-client [ 8488.035580] Key type lgssc unregistered [ 8488.295579] LNet: 188069:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8488.302215] LNetError: 188069:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8488.330747] LNet: Removed LNI 192.168.206.51@tcp [ 8489.158643] Key type .llcrypt unregistered [ 8489.161144] Key type ._llcrypt unregistered [ 8503.814824] Key type ._llcrypt registered [ 8503.823165] Key type .llcrypt registered [ 8505.089501] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8506.544523] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 20:04:04 (1786752244) [ 8523.344994] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8523.424085] alg: No test for adler32 (adler32-zlib) [ 8524.481953] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 8524.719369] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8526.391277] Key type lgssc registered [ 8527.324493] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8616.716551] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8622.448868] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8647.352731] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8671.092446] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8673.855174] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 8697.614424] Lustre: Unmounted lustre-client [ 8823.318407] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8829.446553] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8854.315704] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8903.108995] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 20:10:40 (1786752640) [ 8905.108476] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8907.669247] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 20:10:44 (1786752644) [ 9003.236152] Key type lgssc unregistered [ 9003.458786] LNet: 199527:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9003.466417] LNetError: 199527:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9003.483212] LNet: Removed LNI 192.168.206.51@tcp [ 9004.304350] Key type .llcrypt unregistered [ 9004.307416] Key type ._llcrypt unregistered [ 9019.672764] Key type ._llcrypt registered [ 9019.675774] Key type .llcrypt registered [ 9021.114783] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 20:12:38 (1786752758) [ 9064.210876] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9064.389263] alg: No test for adler32 (adler32-zlib) [ 9065.591231] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 9065.879342] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 9067.647191] Key type lgssc registered [ 9069.181235] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9117.526791] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9123.816818] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9156.856598] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9178.461316] Key type lgssc unregistered [ 9178.805443] LNet: 203260:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9178.808777] LNetError: 203260:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9178.821898] LNet: Removed LNI 192.168.206.51@tcp [ 9179.548163] Key type .llcrypt unregistered [ 9179.558466] Key type ._llcrypt unregistered [ 9194.629415] Key type ._llcrypt registered [ 9194.633138] Key type .llcrypt registered [ 9195.942253] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 20:15:33 (1786752933) [ 9199.180740] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9199.215861] alg: No test for adler32 (adler32-zlib) [ 9200.393663] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 9200.620286] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 9202.415254] Key type lgssc registered [ 9203.624230] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9255.963283] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9261.623679] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9284.341875] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9285.939352] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 9301.478154] Lustre: lustre-MDT0000-mdc-ffff98478635f800: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9311.729964] Lustre: lustre-MDT0001-mdc-ffff98478635f800: Connection to lustre-MDT0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9322.978120] Lustre: 204251:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786753045/real 1786753045] req@000000008dc24d35 x1873546249847424/t0(0) o400->MGC192.168.206.151@tcp@192.168.206.151@tcp:26/25 lens 224/224 e 0 to 1 dl 1786753061 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9323.012092] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 9333.288472] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0x13bc228b121ca010 to 0x13bc228b121cbb14 [ 9333.309445] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 9356.787072] LustreError: lustre-MDT0000-mdc-ffff98478635f800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9356.830986] Lustre: lustre-MDT0000-mdc-ffff98478635f800: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 9360.015477] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9361.575529] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9367.501211] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9369.085214] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9372.415492] Lustre: Unmounted lustre-client [ 9398.421519] Key type lgssc unregistered [ 9398.644688] LNet: 208211:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9398.654242] LNetError: 208211:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9398.674870] LNet: Removed LNI 192.168.206.51@tcp [ 9399.337167] Key type .llcrypt unregistered [ 9399.338851] Key type ._llcrypt unregistered [ 9414.615497] Key type ._llcrypt registered [ 9414.617831] Key type .llcrypt registered [ 9415.768793] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 20:19:13 (1786753153) [ 9418.350220] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9418.369476] alg: No test for adler32 (adler32-zlib) [ 9419.453515] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 9419.725524] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 9421.391201] Key type lgssc registered [ 9422.668355] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9469.994289] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9475.116971] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9527.358451] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9533.149778] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9573.522284] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9595.457167] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9650.120419] Key type lgssc unregistered [ 9650.357565] LNet: 213510:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9650.371116] LNetError: 213510:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9650.389249] LNet: Removed LNI 192.168.206.51@tcp [ 9650.994374] Key type .llcrypt unregistered [ 9650.996190] Key type ._llcrypt unregistered [ 9695.662403] Key type ._llcrypt registered [ 9695.666188] Key type .llcrypt registered [ 9697.461871] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 20:23:54 (1786753434) [ 9735.875177] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9735.914559] alg: No test for adler32 (adler32-zlib) [ 9736.981201] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [ 9737.167929] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 9738.863156] Key type lgssc registered [ 9740.235448] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9825.376667] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9830.872968] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9855.573711] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9896.362714] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 20:27:14 (1786753634) [ 9903.726979] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 20:27:21 (1786753641) [ 9939.192701] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9944.606885] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9961.877673] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9964.414678] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [ 9969.171486] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9971.009531] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9972.664728] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9974.050260] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9979.884462] Lustre: lustre-MDT0000-mdc-ffff984790989000: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9995.231814] Lustre: 215408:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786753718/real 1786753718] req@00000000bc5d80e6 x1873546812859520/t0(0) o400->MGC192.168.206.151@tcp@192.168.206.151@tcp:26/25 lens 224/224 e 0 to 1 dl 1786753734 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9995.270070] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 9995.300228] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0x617c81bfb0dd699d to 0x617c81bfb0dd6b17 [ 9995.316585] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [10001.059495] Lustre: lustre-MDT0000-mdc-ffff984790989000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [10007.085467] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10008.635583] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10012.439261] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10015.734119] Lustre: lustre-MDT0000-mdc-ffff984790989000: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [10031.073194] Lustre: 215407:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1786753754/real 1786753754] req@000000009f6d4ce5 x1873546812867072/t0(0) o400->MGC192.168.206.151@tcp@192.168.206.151@tcp:26/25 lens 224/224 e 0 to 1 dl 1786753770 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10031.104718] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [10041.335178] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0x617c81bfb0dd6b17 to 0x617c81bfb0dd6e20 [10041.351575] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [10047.684708] Lustre: lustre-MDT0000-mdc-ffff984790989000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [10058.628606] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10060.459871] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10065.886097] Lustre: Unmounted lustre-client [10135.923374] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10142.241104] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10165.718467] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10166.633233] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [10174.264144] Lustre: Unmounted lustre-client [10201.394798] Key type lgssc unregistered [10201.685155] LNet: 225995:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10201.691977] LNetError: 225995:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10201.718055] LNet: Removed LNI 192.168.206.51@tcp [10202.488908] Key type .llcrypt unregistered [10202.493327] Key type ._llcrypt unregistered [10217.923722] Key type ._llcrypt registered [10217.926862] Key type .llcrypt registered [10219.340964] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 20:32:36 (1786753956) [10223.850602] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10223.908991] alg: No test for adler32 (adler32-zlib) [10224.981280] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [10225.283432] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [10226.999981] Key type lgssc registered [10228.302734] Lustre: Echo OBD driver; http://www.lustre.org/ [10280.726395] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10286.277220] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10308.680448] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10311.593881] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [10321.044963] Lustre: Unmounted lustre-client [10388.359666] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10394.723132] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10416.843518] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10417.421724] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [10426.400885] Lustre: Unmounted lustre-client [10497.284288] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10502.958790] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10521.966401] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10522.638466] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [10524.833525] Lustre: Unmounted lustre-client [10562.295532] Key type lgssc unregistered [10562.774841] LNet: 233046:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10562.792842] LNetError: 233046:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10562.816139] LNet: Removed LNI 192.168.206.51@tcp [10563.920094] Key type .llcrypt unregistered [10563.923514] Key type ._llcrypt unregistered [10581.800299] Key type ._llcrypt registered [10581.802535] Key type .llcrypt registered [10583.145931] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 20:38:40 (1786754320) [10585.932819] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10585.959727] alg: No test for adler32 (adler32-zlib) [10586.967807] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [10587.215286] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [10588.919181] Key type lgssc registered [10589.886596] Lustre: Echo OBD driver; http://www.lustre.org/ [10634.547343] Key type lgssc unregistered [10634.886430] LNet: 235369:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10634.894206] LNetError: 235369:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10634.930121] LNet: Removed LNI 192.168.206.51@tcp [10635.775968] Key type .llcrypt unregistered [10635.779613] Key type ._llcrypt unregistered [10665.633367] Key type ._llcrypt registered [10665.639247] Key type .llcrypt registered [10666.276116] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10666.312647] alg: No test for adler32 (adler32-zlib) [10667.498301] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [10667.782074] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [10669.516950] Key type lgssc registered [10670.837377] Lustre: Echo OBD driver; http://www.lustre.org/ [10757.962078] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10763.895441] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10784.525411] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10831.058713] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10832.286156] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 20:42:50 (1786754570) [10864.807076] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10870.867327] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10891.892185] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10915.032576] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10916.724383] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [10921.973929] Lustre: lustre-OST0001-osc-ffff984788573800: Connection to lustre-OST0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [10929.155490] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10939.480903] Lustre: Unmounted lustre-client [10975.703907] Key type lgssc unregistered [10975.985802] LNet: 242483:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10975.992094] LNetError: 242483:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10976.004772] LNet: Removed LNI 192.168.206.51@tcp [10976.739111] Key type .llcrypt unregistered [10976.744080] Key type ._llcrypt unregistered [11008.899430] Key type ._llcrypt registered [11008.901749] Key type .llcrypt registered [11010.283899] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 20:45:47 (1786754747) [11024.069643] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11024.116850] alg: No test for adler32 (adler32-zlib) [11025.188283] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [11025.438909] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [11027.135140] Key type lgssc registered [11028.181806] Lustre: Echo OBD driver; http://www.lustre.org/ [11073.196449] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11078.783584] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11101.218280] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 20:47:18 (1786754838) [11138.532684] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11144.995193] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11165.871147] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11167.793456] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [11180.551986] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11181.534349] Lustre: Unmounted lustre-client [11283.248978] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11289.115761] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11343.930657] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11344.612035] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [11348.306734] Lustre: Unmounted lustre-client [11377.723911] Key type lgssc unregistered [11377.997691] LNet: 250181:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11378.004867] LNetError: 250181:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11378.018756] LNet: Removed LNI 192.168.206.51@tcp [11378.716798] Key type .llcrypt unregistered [11378.720379] Key type ._llcrypt unregistered [11408.447874] Key type ._llcrypt registered [11408.450987] Key type .llcrypt registered [11408.879308] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11408.911621] alg: No test for adler32 (adler32-zlib) [11410.053681] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [11410.310639] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [11411.999293] Key type lgssc registered [11413.495751] Lustre: Echo OBD driver; http://www.lustre.org/ [11497.725703] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11502.905660] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11528.247358] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11575.307993] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11576.814467] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 20:55:14 (1786755314) [11605.956647] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11611.347591] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11636.095385] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11641.210022] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [11644.234793] Lustre: Unmounted lustre-client [11674.192280] Key type lgssc unregistered [11674.482771] LNet: 256826:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11674.496181] LNetError: 256826:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11674.512578] LNet: Removed LNI 192.168.206.51@tcp [11675.279899] Key type .llcrypt unregistered [11675.285550] Key type ._llcrypt unregistered [11690.411967] Key type ._llcrypt registered [11690.414436] Key type .llcrypt registered [11691.461209] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11693.299794] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 20:57:10 (1786755430) [11703.379269] Key type .llcrypt unregistered [11703.384747] Key type ._llcrypt unregistered [11712.130332] Key type ._llcrypt registered [11712.133775] Key type .llcrypt registered [11712.557362] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11712.575980] alg: No test for adler32 (adler32-zlib) [11713.739479] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [11714.041033] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [11715.727811] Key type lgssc registered [11716.933358] Lustre: Echo OBD driver; http://www.lustre.org/ [11777.467790] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11794.081519] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [11797.267158] Lustre: Unmounted lustre-client [11822.159989] Key type lgssc unregistered [11822.461990] LNet: 260291:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11822.473525] LNetError: 260291:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11822.511145] LNet: Removed LNI 192.168.206.51@tcp [11823.445624] Key type .llcrypt unregistered [11823.452221] Key type ._llcrypt unregistered [11840.389906] Key type ._llcrypt registered [11840.395817] Key type .llcrypt registered [11841.947323] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 20:59:39 (1786755579) [11845.040480] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11845.059193] alg: No test for adler32 (adler32-zlib) [11846.206793] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [11846.572972] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [11848.391573] Key type lgssc registered [11850.218878] Lustre: Echo OBD driver; http://www.lustre.org/ [11940.888607] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11978.032949] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11983.976233] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11985.804616] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [11988.735594] Lustre: Unmounted lustre-client [12021.292429] Key type lgssc unregistered [12021.636583] LNet: 263853:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12021.645789] LNetError: 263853:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12022.694661] LNet: Removed LNI 192.168.206.51@tcp [12023.540635] Key type .llcrypt unregistered [12023.544855] Key type ._llcrypt unregistered [12042.060062] Key type ._llcrypt registered [12042.065671] Key type .llcrypt registered [12043.641728] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 21:03:00 (1786755780) [12046.368520] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12046.405040] alg: No test for adler32 (adler32-zlib) [12047.527699] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [12047.878400] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [12049.583210] Key type lgssc registered [12051.304743] Lustre: Echo OBD driver; http://www.lustre.org/ [12100.122604] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12106.195586] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12127.331453] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12129.034985] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [12134.374468] Lustre: lustre-MDT0000-mdc-ffff984790988800: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [12140.194165] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12140.228094] LustreError: 267012:0:(file.c:6156:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12140.602133] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [12140.689553] Lustre: Unmounted lustre-client [12160.758935] Key type lgssc unregistered [12161.039896] LNet: 267428:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12161.048615] LNetError: 267428:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12161.064951] LNet: Removed LNI 192.168.206.51@tcp [12161.744908] Key type .llcrypt unregistered [12161.746885] Key type ._llcrypt unregistered [12176.137581] Key type ._llcrypt registered [12176.139871] Key type .llcrypt registered [12177.644365] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 21:05:15 (1786755915) [12179.643170] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12179.676699] alg: No test for adler32 (adler32-zlib) [12180.697208] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [12180.977876] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [12182.703261] Key type lgssc registered [12183.983355] Lustre: Echo OBD driver; http://www.lustre.org/ [12235.611936] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12241.286457] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12261.192608] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12262.831394] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [12281.187990] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12283.165405] Lustre: Unmounted lustre-client [12302.951424] Key type lgssc unregistered [12303.211475] LNet: 271005:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12303.220946] LNetError: 271005:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12303.243462] LNet: Removed LNI 192.168.206.51@tcp [12304.008303] Key type .llcrypt unregistered [12304.011773] Key type ._llcrypt unregistered [12319.194618] Key type ._llcrypt registered [12319.196590] Key type .llcrypt registered [12320.314287] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 21:07:38 (1786756058) [12335.565123] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12335.609434] alg: No test for adler32 (adler32-zlib) [12336.705461] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [12336.954265] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [12338.671226] Key type lgssc registered [12339.952076] Lustre: Echo OBD driver; http://www.lustre.org/ [12448.318645] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12450.986061] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [12491.238394] Lustre: lustre-MDT0001-mdc-ffff984790952000: Connection to lustre-MDT0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [12500.858181] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12511.229662] Lustre: Unmounted lustre-client [12545.138064] Key type lgssc unregistered [12545.418198] LNet: 276796:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12545.422286] LNetError: 276796:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12545.437209] LNet: Removed LNI 192.168.206.51@tcp [12546.263082] Key type .llcrypt unregistered [12546.267326] Key type ._llcrypt unregistered [12561.608917] Key type ._llcrypt registered [12561.612899] Key type .llcrypt registered [12562.859566] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 21:11:40 (1786756300) [12564.151933] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12565.630209] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 21:11:43 (1786756303) [12567.003415] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12568.400382] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 21:11:46 (1786756306) [12569.836993] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12571.266538] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 21:11:49 (1786756309) [12572.625187] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12574.168331] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 21:11:51 (1786756311) [12575.528871] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12577.235540] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 21:11:55 (1786756315) [12585.465714] Key type .llcrypt unregistered [12585.468444] Key type ._llcrypt unregistered [12591.814040] Key type ._llcrypt registered [12591.816436] Key type .llcrypt registered [12592.113658] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12592.127293] alg: No test for adler32 (adler32-zlib) [12593.191127] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [12593.434907] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [12595.111388] Key type lgssc registered [12596.563598] Lustre: Echo OBD driver; http://www.lustre.org/ [12669.321400] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12675.571701] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12699.176605] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12702.180470] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [12705.042671] Lustre: Unmounted lustre-client [12740.967225] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 21:14:38 (1786756478) [12773.076949] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12778.871343] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12813.029773] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12824.126584] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [12826.332925] Lustre: Unmounted lustre-client [12869.934164] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 21:16:47 (1786756607) [12870.950808] LNet: 1 local NIs in recovery (showing 1): 192.168.206.51@tcp [13519.194939] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13524.268822] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13559.006128] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13647.070869] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 21:29:44 (1786757384) [13657.990436] Key type lgssc unregistered [13658.342654] LNet: 290326:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13658.349777] LNetError: 290326:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13658.380384] LNet: Removed LNI 192.168.206.51@tcp [13659.213322] Key type .llcrypt unregistered [13659.217680] Key type ._llcrypt unregistered [13799.657252] Key type ._llcrypt registered [13799.660080] Key type .llcrypt registered [13800.003680] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13800.016784] alg: No test for adler32 (adler32-zlib) [13801.051669] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [13801.280634] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [13802.904133] Key type lgssc registered [13804.077135] Lustre: Echo OBD driver; http://www.lustre.org/ [13885.462183] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13890.623910] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13916.384556] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13958.771840] Key type lgssc unregistered [13959.009785] LNet: 294034:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13959.023528] LNetError: 294034:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13959.034973] LNet: Removed LNI 192.168.206.51@tcp [13960.154604] Key type .llcrypt unregistered [13960.165101] Key type ._llcrypt unregistered [13999.985501] Key type ._llcrypt registered [13999.987621] Key type .llcrypt registered [14001.259397] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 21:35:38 (1786757738) [14019.836089] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14019.979016] alg: No test for adler32 (adler32-zlib) [14021.069616] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [14021.322851] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [14023.032681] Key type lgssc registered [14024.091354] Lustre: Echo OBD driver; http://www.lustre.org/ [14070.941060] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 21:36:48 (1786757808) [14082.717347] Key type lgssc unregistered [14083.053678] LNet: 297591:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14083.061947] LNetError: 297591:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14083.092216] LNet: Removed LNI 192.168.206.51@tcp [14083.902846] Key type .llcrypt unregistered [14083.908858] Key type ._llcrypt unregistered [14094.503518] Key type ._llcrypt registered [14094.505245] Key type .llcrypt registered [14094.853787] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14094.875885] alg: No test for adler32 (adler32-zlib) [14095.888375] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [14096.223806] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [14097.904693] Key type lgssc registered [14098.927263] Lustre: Echo OBD driver; http://www.lustre.org/ [14154.772208] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14160.048549] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14182.644250] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14449.210534] LNet: Added LNI 192.168.206.51@tcp50 [8/256/0/180] [14451.464313] LNet: Removed LNI 192.168.206.51@tcp [14453.892495] Lustre: 301999:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff984786359000: config has no valid NIDs, force dynamic NIDs [14455.116373] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [14455.320851] Lustre: Unmounted lustre-client [14457.920653] Key type lgssc unregistered [14458.242561] LNet: 302261:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14458.247427] LNetError: 302261:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14458.275104] LNet: Removed LNI 192.168.206.51@tcp50 [14458.974483] Key type .llcrypt unregistered [14458.977236] Key type ._llcrypt unregistered [14484.771177] Key type ._llcrypt registered [14484.777882] Key type .llcrypt registered [14485.135639] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14485.175954] alg: No test for adler32 (adler32-zlib) [14486.368986] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [14486.684955] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [14488.407258] Key type lgssc registered [14489.585726] Lustre: Echo OBD driver; http://www.lustre.org/ [14551.627654] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14558.200335] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14569.045600] LNet: Added LNI 192.168.206.51@tcp50 [8/256/0/180] [14570.017699] LNet: Removed LNI 192.168.206.51@tcp [14571.390327] Lustre: 304961:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff984784f49000: config has no valid NIDs, force dynamic NIDs [14572.756730] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [14573.567906] Lustre: Unmounted lustre-client [14611.895499] Key type lgssc unregistered [14612.274672] LNet: 305835:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14612.280969] LNetError: 305835:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14612.299822] LNet: Removed LNI 192.168.206.51@tcp50 [14612.871826] Key type .llcrypt unregistered [14612.874618] Key type ._llcrypt unregistered [14627.302672] Key type ._llcrypt registered [14627.304251] Key type .llcrypt registered [14628.358172] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 21:46:06 (1786758366) [14652.744446] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14652.777411] alg: No test for adler32 (adler32-zlib) [14654.052762] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [14654.363189] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [14656.223569] Key type lgssc registered [14658.309241] Lustre: Echo OBD driver; http://www.lustre.org/ [14747.861729] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14754.342276] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14777.812239] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14818.256429] Key type lgssc unregistered [14818.469156] LNet: 310590:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14818.478672] LNetError: 310590:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14818.504270] LNet: Removed LNI 192.168.206.51@tcp [14819.128625] Key type .llcrypt unregistered [14819.130631] Key type ._llcrypt unregistered [14830.820100] Key type ._llcrypt registered [14830.821910] Key type .llcrypt registered [14831.958493] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 21:49:29 (1786758569) [14834.198311] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14834.217535] alg: No test for adler32 (adler32-zlib) [14835.174558] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [14835.416838] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [14837.071304] Key type lgssc registered [14838.097907] Lustre: Echo OBD driver; http://www.lustre.org/ [14887.419571] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14893.413693] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14915.620567] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14918.357046] Lustre: Mounted lustre-client - version 2.17.57_1_g59aa375 [14975.645371] Lustre: Mounted fs15246-client - version 2.17.57_1_g59aa375 [14990.137198] Lustre: Unmounted fs15246-client [15017.938708] Lustre: Unmounted lustre-client [15044.553671] Key type lgssc unregistered [15044.837888] LNet: 315454:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15044.849385] LNetError: 315454:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15044.875055] LNet: Removed LNI 192.168.206.51@tcp [15045.667643] Key type .llcrypt unregistered [15045.673954] Key type ._llcrypt unregistered [15056.921704] Key type ._llcrypt registered [15056.923558] Key type .llcrypt registered [15058.557470] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 21:53:15 (1786758795) [15060.357795] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15060.387249] alg: No test for adler32 (adler32-zlib) [15061.528353] Lustre: Lustre: Build Version: 2.17.57_1_g59aa375 [15061.791046] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [15063.481903] Key type lgssc registered [15064.780021] Lustre: Echo OBD driver; http://www.lustre.org/ [15187.516301] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15193.182527] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15216.312596] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15325.465607] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15047 sec ========= 21:57:42 (1786759062) [15326.958648] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 21:57:44 (1786759064) === [15330.111897] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 21:57:47 (1786759067) === [15365.197805] Key type lgssc unregistered [15365.469184] LNet: 324726:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15365.489422] LNetError: 324726:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15365.532520] LNet: Removed LNI 192.168.206.51@tcp [15366.251949] Key type .llcrypt unregistered [15366.253558] Key type ._llcrypt unregistered