[ 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 450323041 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.003099] x2apic enabled [ 0.004006] Switched APIC routing to physical x2apic. [ 0.005014] kvm-guest: setup PV IPIs [ 0.007896] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008020] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009010] pid_max: default: 32768 minimum: 301 [ 0.010124] LSM: Security Framework initializing [ 0.011068] Yama: becoming mindful. [ 0.012040] SELinux: Initializing. [ 0.013142] *** VALIDATE selinux *** [ 0.021048] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.025444] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.026146] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.027111] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028114] *** VALIDATE tmpfs *** [ 0.029338] *** VALIDATE proc *** [ 0.031085] *** VALIDATE cgroup *** [ 0.032009] *** VALIDATE cgroup2 *** [ 0.033262] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035116] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037032] Spectre V2 : User space: Vulnerable [ 0.038009] Speculative Store Bypass: Vulnerable [ 0.040694] debug: unmapping init [mem 0xffffffff86659000-0xffffffff86660fff] [ 0.042859] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043704] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044023] ... version: 2 [ 0.045012] ... bit width: 48 [ 0.046013] ... generic registers: 4 [ 0.047014] ... value mask: 0000ffffffffffff [ 0.048017] ... max period: 00007fffffffffff [ 0.049032] ... fixed-purpose events: 3 [ 0.050013] ... event mask: 000000070000000f [ 0.051363] rcu: Hierarchical SRCU implementation. [ 0.053364] smp: Bringing up secondary CPUs ... [ 0.054566] x86: Booting SMP configuration: [ 0.055025] .... node #0, CPUs: #1 #2 #3 [ 0.059104] smp: Brought up 1 node, 4 CPUs [ 0.061018] smpboot: Max logical packages: 1 [ 0.062018] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.169811] node 0 deferred pages initialised in 106ms [ 0.175121] devtmpfs: initialized [ 0.176331] x86/mm: Memory block size: 128MB [ 0.180000] gcov: version magic: 0x41383552 [ 0.185070] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.186122] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.189306] pinctrl core: initialized pinctrl subsystem [ 0.191210] [ 0.191693] ************************************************************* [ 0.194013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.197014] ** ** [ 0.199013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.201017] ** ** [ 0.204014] ** This means that this kernel is built to expose internal ** [ 0.206008] ** IOMMU data structures, which may compromise security on ** [ 0.208010] ** your system. ** [ 0.210014] ** ** [ 0.212018] ** If you see this message and you are not debugging the ** [ 0.215012] ** kernel, report this immediately to your vendor! ** [ 0.217009] ** ** [ 0.219012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.221019] ************************************************************* [ 0.223529] NET: Registered protocol family 16 [ 0.226597] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.229085] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.232095] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.236060] cpuidle: using governor menu [ 0.237719] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.240623] PCI: Using configuration type 1 for base access [ 0.243159] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.252132] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.255102] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.260039] cryptd: max_cpu_qlen set to 1000 [ 0.262323] ACPI: Added _OSI(Module Device) [ 0.264021] ACPI: Added _OSI(Processor Device) [ 0.266029] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.267021] ACPI: Added _OSI(Processor Aggregator Device) [ 0.272116] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.279387] ACPI: Interpreter enabled [ 0.280082] ACPI: PM: (supports S0 S3 S4 S5) [ 0.285037] ACPI: Using IOAPIC for interrupt routing [ 0.287126] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.291535] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.302798] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.305038] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.307019] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.310081] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.316623] acpiphp: Slot [2] registered [ 0.318187] acpiphp: Slot [5] registered [ 0.319170] acpiphp: Slot [6] registered [ 0.321122] acpiphp: Slot [3] registered [ 0.322144] acpiphp: Slot [4] registered [ 0.324162] acpiphp: Slot [7] registered [ 0.325116] acpiphp: Slot [8] registered [ 0.327110] acpiphp: Slot [9] registered [ 0.329194] acpiphp: Slot [10] registered [ 0.331218] acpiphp: Slot [11] registered [ 0.333153] acpiphp: Slot [12] registered [ 0.335207] acpiphp: Slot [13] registered [ 0.337166] acpiphp: Slot [14] registered [ 0.339286] acpiphp: Slot [15] registered [ 0.342211] acpiphp: Slot [16] registered [ 0.344203] acpiphp: Slot [17] registered [ 0.345187] acpiphp: Slot [18] registered [ 0.347190] acpiphp: Slot [19] registered [ 0.349166] acpiphp: Slot [20] registered [ 0.354202] acpiphp: Slot [21] registered [ 0.359105] acpiphp: Slot [22] registered [ 0.360123] acpiphp: Slot [23] registered [ 0.361236] acpiphp: Slot [24] registered [ 0.363125] acpiphp: Slot [25] registered [ 0.365120] acpiphp: Slot [26] registered [ 0.366098] acpiphp: Slot [27] registered [ 0.368094] acpiphp: Slot [28] registered [ 0.370200] acpiphp: Slot [29] registered [ 0.371000] acpiphp: Slot [30] registered [ 0.371000] acpiphp: Slot [31] registered [ 0.373069] PCI host bridge to bus 0000:00 [ 0.375025] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.378026] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.380036] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.383030] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.386025] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.388024] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.390175] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.394138] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.398019] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.408020] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.412485] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.416045] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.418065] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.421033] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.424777] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.428119] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.431052] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.434986] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.440014] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.452015] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.457014] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.463091] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.472021] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.480016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.495018] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.505878] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.513015] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.521015] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.537020] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.546063] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.549440] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.552378] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.554345] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.556241] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.561127] iommu: Default domain type: Passthrough [ 0.563480] SCSI subsystem initialized [ 0.564133] ACPI: bus type USB registered [ 0.566113] usbcore: registered new interface driver usbfs [ 0.568079] usbcore: registered new interface driver hub [ 0.570094] usbcore: registered new device driver usb [ 0.571203] pps_core: LinuxPPS API ver. 1 registered [ 0.573012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.576062] PTP clock support registered [ 0.579074] EDAC MC: Ver: 3.0.0 [ 0.581138] PCI: Using ACPI for IRQ routing [ 0.583814] NetLabel: Initializing [ 0.585011] NetLabel: domain hash size = 128 [ 0.587011] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.589075] NetLabel: unlabeled traffic allowed by default [ 0.591151] vgaarb: loaded [ 0.593266] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.595016] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.604884] clocksource: Switched to clocksource kvm-clock [ 0.717452] VFS: Disk quotas dquot_6.6.0 [ 0.719668] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.723431] *** VALIDATE ramfs *** [ 0.725252] *** VALIDATE hugetlbfs *** [ 0.728098] pnp: PnP ACPI init [ 0.731124] pnp: PnP ACPI: found 6 devices [ 0.756665] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.760365] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.763302] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.766237] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.769230] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.772047] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.775310] NET: Registered protocol family 2 [ 0.777859] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.782680] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.786573] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.792903] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.796662] TCP: Hash tables configured (established 65536 bind 65536) [ 0.799800] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.802952] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.806454] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.809203] NET: Registered protocol family 1 [ 0.812877] RPC: Registered named UNIX socket transport module. [ 0.815295] RPC: Registered udp transport module. [ 0.817043] RPC: Registered tcp transport module. [ 0.818857] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.822745] NET: Registered protocol family 44 [ 0.825024] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.827819] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.830457] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.833030] PCI: CLS 0 bytes, default 64 [ 0.834629] Unpacking initramfs... [ 2.248460] debug: unmapping init [mem 0xffff91c2bcc64000-0xffff91c2bffcffff] [ 2.253025] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.255490] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.258624] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.771855] Initialise system trusted keyrings [ 2.773801] Key type blacklist registered [ 2.776140] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.785555] zbud: loaded [ 2.788528] *** VALIDATE nfs *** [ 2.790562] *** VALIDATE nfs4 *** [ 2.792147] pstore: using deflate compression [ 2.795950] Platform Keyring initialized [ 2.917760] NET: Registered protocol family 38 [ 2.920041] Key type asymmetric registered [ 2.921738] Asymmetric key parser 'x509' registered [ 2.924378] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.928230] io scheduler mq-deadline registered [ 2.930440] io scheduler kyber registered [ 2.932316] io scheduler bfq registered [ 2.934810] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.937922] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.940566] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.943595] ACPI: Power Button [PWRF] [ 2.950277] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.957933] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.968740] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.997615] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.027639] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.033883] Non-volatile memory driver v1.3 [ 3.035855] Linux agpgart interface v0.103 [ 3.072563] virtio_blk virtio1: [vda] 150616 512-byte logical blocks (77.1 MB/73.5 MiB) [ 3.076276] vda: detected capacity change from 0 to 77115392 [ 3.090674] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.093637] vdb: detected capacity change from 0 to 1073741824 [ 3.102293] libphy: Fixed MDIO Bus: probed [ 3.114085] usbcore: registered new interface driver usbserial_generic [ 3.117720] usbserial: USB Serial support registered for generic [ 3.120319] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.124700] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.126611] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.129683] mousedev: PS/2 mouse device common for all mice [ 3.133380] rtc_cmos 00:05: RTC can wake from S4 [ 3.133486] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.139332] rtc_cmos 00:05: registered as rtc0 [ 3.142458] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.143930] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.145960] intel_pstate: CPU model not supported [ 3.152170] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.155149] hid: raw HID events driver (C) Jiri Kosina [ 3.158310] usbcore: registered new interface driver usbhid [ 3.160202] usbhid: USB HID core driver [ 3.161730] drop_monitor: Initializing network drop monitor service [ 3.164134] Initializing XFRM netlink socket [ 3.166232] NET: Registered protocol family 10 [ 3.170279] Segment Routing with IPv6 [ 3.171841] NET: Registered protocol family 17 [ 3.174284] mpls_gso: MPLS GSO support [ 3.181202] RAS: Correctable Errors collector initialized. [ 3.183472] AVX version of gcm_enc/dec engaged. [ 3.185189] AES CTR mode by8 optimization enabled [ 3.264553] sched_clock: Marking stable (3264530548, 0)->(4181935904, -917405356) [ 3.268491] registered taskstats version 1 [ 3.270641] Loading compiled-in X.509 certificates [ 3.273049] zswap: loaded using pool lzo/zbud [ 3.298107] Key type big_key registered [ 3.312501] Key type encrypted registered [ 3.315861] ima: No TPM chip found, activating TPM-bypass! [ 3.318602] ima: Allocated hash algorithm: sha1 [ 3.320760] ima: No architecture policies found [ 3.322591] evm: Initialising EVM extended attributes: [ 3.324878] evm: security.selinux [ 3.326720] evm: security.ima [ 3.327776] evm: security.capability [ 3.328953] evm: HMAC attrs: 0x1 [ 3.331222] rtc_cmos 00:05: setting system clock to 2026-10-02 12:51:34 UTC (1790945494) [ 3.337485] debug: unmapping init [mem 0xffffffff87603000-0xffffffff877fffff] [ 3.340605] debug: unmapping init [mem 0xffffffff86382000-0xffffffff86658fff] [ 3.349155] Write protecting the kernel read-only data: 28672k [ 3.352428] debug: unmapping init [mem 0xffffffff84a03000-0xffffffff84bfffff] [ 3.356273] debug: unmapping init [mem 0xffffffff85314000-0xffffffff853fffff] [ 3.388720] 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.398322] systemd[1]: Detected virtualization kvm. [ 3.400165] systemd[1]: Detected architecture x86-64. [ 3.402041] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.426727] systemd[1]: No hostname configured. [ 3.428398] systemd[1]: Set hostname to . [ 3.430357] random: systemd: uninitialized urandom read (16 bytes read) [ 3.432902] systemd[1]: Initializing machine ID from random generator. [ 3.476482] random: ln: uninitialized urandom read (6 bytes read) [ 3.596668] random: systemd: uninitialized urandom read (16 bytes read) [ 3.600837] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 3.608252] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.614909] systemd[1]: Reached target Local Encrypted Volumes. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target Local File Systems. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... [ OK ] Reached target Swap. [ OK ] Reached target Slices. [ OK ] Reached target Timers. [ OK ] Listening on Journal Socket (/dev/log). Starting Apply Kernel Variables... [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Reached target Initrd Root Device. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. 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.282184] device-mapper: uevent: version 1.0.3 [ 4.285638] 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.070072] virtio_net virtio0 ens2: renamed from eth0 [ 5.157870] scsi host0: ata_piix [ 5.172131] scsi host1: ata_piix [ 5.174307] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.176890] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.532364] dracut-initqueue[583]: RTNETLINK answers: File exists [ 9.835793] random: crng init done [ 9.837750] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 11.674597] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Root Device. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 14.225819] printk: systemd: 26 output lines suppressed due to ratelimiting [ 15.033720] SELinux: Disabled at runtime. [ 15.127653] 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) [ 15.140773] systemd[1]: Detected virtualization kvm. [ 15.143398] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 16.345543] systemd[1]: initrd-switch-root.service: Succeeded. [ 16.352745] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 16.376447] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 16.391071] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 16.403415] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 16.419814] systemd[1]: Starting Journal Service... Starting Journal Service... [ 16.434462] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-getty.slice. [ OK ] Listening on udev Kernel Socket. Activating swap /dev/disk/by-label/SWAP... [ OK ] Stopped target Switch Root. [ OK ] Listening on RPCbind Server Activation Socket. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Reached target RPC Port Mapper. [ 16.576447] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Stopped target Initrd File Systems. Mounting Huge Pages File System... [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Apply Kernel Variables... [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Stopped target Initrd Root File System. Starting Remount Root and Kernel File Systems... Mounting Kernel Debug File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Huge Pages File System. [ OK ] Started Apply Kernel Variables. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted Kernel Debug File System. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ OK ] Mounted /mnt. [ 17.662251] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 18.324022] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 18.363271] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 18.856524] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 18.941244] EDAC sbridge: Ver: 1.1.2 [ 22.994098] Key type dns_resolver registered [* ] A start job is running for Configur…-only root support (7s / no limit)[ 23.565747] NFS: Registering the id_resolver key type [ 23.568220] Key type id_resolver registered [ 23.570513] Key type id_legacy registered [** ] A start job is running for Configur…-only root support (7s / no limit) [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. Starting Login Service... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... [ OK ] Started OpenSSH server daemon. [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting System Logging Service... Starting Notify NFS peers of a restart... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg626-client login: [ 90.488821] libcfs: loading out-of-tree module taints kernel. [ 90.518111] Key type ._llcrypt registered [ 90.521821] Key type .llcrypt registered [ 90.948509] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 90.956297] alg: No test for adler32 (adler32-zlib) [ 92.334464] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 93.356018] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 95.152185] Key type lgssc registered [ 97.187708] Lustre: Echo OBD driver; http://www.lustre.org/ [ 168.633065] hrtimer: interrupt took 4057148 ns [ 266.582450] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 275.074349] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 290.364158] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing check_logdir /tmp/testlogs/ [ 292.320484] Lustre: lustre-OST0000-osc-ffff91c303279000: disconnect after 22s idle [ 296.653506] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing yml_node [ 301.124905] Lustre: DEBUG MARKER: Client: 2.17.59.2 [ 303.883542] Lustre: DEBUG MARKER: MDS: 2.17.59.2 [ 306.999460] Lustre: DEBUG MARKER: OSS: 2.17.59.2 [ 309.092835] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Fri Oct 2 08:56:38 EDT 2026 [ 328.851337] Lustre: DEBUG MARKER: only running tests: 33-75 [ 330.769235] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 332.488369] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 336.201326] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 346.551745] Lustre: Unmounted lustre-client [ 458.199642] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 464.360271] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 487.746402] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 531.935817] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 09:00:21 (1790946021) [ 534.214457] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 536.015860] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 09:00:25 (1790946025) [ 570.892181] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 576.860194] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 597.053394] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 597.668973] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 602.234656] Lustre: Unmounted lustre-client [ 629.769322] Key type lgssc unregistered [ 630.012139] LNet: 15171:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 630.018880] LNetError: 15171:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 630.036703] LNet: Removed LNI 192.168.206.26@tcp [ 630.754230] Key type .llcrypt unregistered [ 630.756880] Key type ._llcrypt unregistered [ 644.178459] Key type ._llcrypt registered [ 644.183572] Key type .llcrypt registered [ 645.253333] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 09:02:15 (1790946135) [ 646.449896] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 646.613095] alg: No test for adler32 (adler32-zlib) [ 647.652532] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 647.876264] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 649.592226] Key type lgssc registered [ 650.882745] Lustre: Echo OBD driver; http://www.lustre.org/ [ 722.595078] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 806.204480] Lustre: Unmounted lustre-client [ 835.661166] Key type lgssc unregistered [ 835.937591] LNet: 18979:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 835.945397] LNetError: 18979:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 835.968495] LNet: Removed LNI 192.168.206.26@tcp [ 836.798142] Key type .llcrypt unregistered [ 836.802075] Key type ._llcrypt unregistered [ 847.417215] Key type ._llcrypt registered [ 847.420609] Key type .llcrypt registered [ 849.152326] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 09:05:38 (1790946338) [ 851.473278] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 851.495946] alg: No test for adler32 (adler32-zlib) [ 852.563518] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 852.836847] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 854.512673] Key type lgssc registered [ 855.691477] Lustre: Echo OBD driver; http://www.lustre.org/ [ 903.601667] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 909.239437] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 931.371814] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 932.981662] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 945.476076] Lustre: Unmounted lustre-client [ 985.661824] Key type lgssc unregistered [ 986.026372] LNet: 22598:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 986.041087] LNetError: 22598:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 986.061987] LNet: Removed LNI 192.168.206.26@tcp [ 986.933574] Key type .llcrypt unregistered [ 986.937970] Key type ._llcrypt unregistered [ 997.012203] Key type ._llcrypt registered [ 997.014680] Key type .llcrypt registered [ 998.159526] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 09:08:07 (1790946487) [ 1000.784716] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1000.849426] alg: No test for adler32 (adler32-zlib) [ 1001.975232] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 1002.246246] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 1003.920244] Key type lgssc registered [ 1005.009507] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1053.361619] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1058.505818] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1076.008821] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1078.812495] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 1084.104986] Lustre: Unmounted lustre-client [ 1113.023798] Key type lgssc unregistered [ 1113.434822] LNet: 25804:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1113.456903] LNetError: 25804:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1113.480975] LNet: Removed LNI 192.168.206.26@tcp [ 1114.746432] Key type .llcrypt unregistered [ 1114.753226] Key type ._llcrypt unregistered [ 1135.563270] Key type ._llcrypt registered [ 1135.565644] Key type .llcrypt registered [ 1136.741678] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 09:10:26 (1790946626) [ 1139.024991] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1139.084799] alg: No test for adler32 (adler32-zlib) [ 1140.226645] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 1140.404570] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 1142.072976] Key type lgssc registered [ 1143.124610] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1188.987577] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1194.050276] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1216.830554] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1219.556443] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 1224.683632] Lustre: lustre-MDT0000-mdc-ffff91c318ad9000: Connection to lustre-MDT0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1234.948219] Lustre: lustre-MDT0001-mdc-ffff91c318ad9000: Connection to lustre-MDT0001 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1242.106131] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1251.296774] Lustre: 26768:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790946726/real 1790946726] req@000000000e6fdf30 x1877943654553600/t0(0) o400->MGC192.168.206.126@tcp@192.168.206.126@tcp:26/25 lens 224/224 e 0 to 1 dl 1790946742 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1251.351613] LustreError: MGC192.168.206.126@tcp: Connection to MGS (at 192.168.206.126@tcp) was lost; in progress operations using this service will fail [ 1252.438234] Lustre: Unmounted lustre-client [ 1272.264622] Key type lgssc unregistered [ 1272.508519] LNet: 29484:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1272.512398] LNetError: 29484:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1272.534415] LNet: Removed LNI 192.168.206.26@tcp [ 1273.232162] Key type .llcrypt unregistered [ 1273.237844] Key type ._llcrypt unregistered [ 1289.740912] Key type ._llcrypt registered [ 1289.743820] Key type .llcrypt registered [ 1291.147915] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 09:13:00 (1790946780) [ 1293.598655] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1293.633176] alg: No test for adler32 (adler32-zlib) [ 1294.716391] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 1295.022146] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 1296.728258] Key type lgssc registered [ 1298.007932] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1343.203145] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1348.575051] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1367.439327] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1369.034939] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 1374.185375] Lustre: lustre-OST0000-osc-ffff91c318ada000: Connection to lustre-OST0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1380.782399] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1391.133671] Lustre: Unmounted lustre-client [ 1417.858854] Key type lgssc unregistered [ 1418.173332] LNet: 33114:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1418.189962] LNetError: 33114:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1418.213694] LNet: Removed LNI 192.168.206.26@tcp [ 1418.783744] Key type .llcrypt unregistered [ 1418.788335] Key type ._llcrypt unregistered [ 1433.505969] Key type ._llcrypt registered [ 1433.508962] Key type .llcrypt registered [ 1434.631267] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 09:15:24 (1790946924) [ 1436.752297] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1436.773198] alg: No test for adler32 (adler32-zlib) [ 1437.804515] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 1437.987717] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 1439.624221] Key type lgssc registered [ 1440.721424] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1489.332638] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1495.425918] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1515.046316] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1516.642547] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 1528.166841] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1532.597311] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1544.038823] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-10-02 9h17m13s [ 1545.681786] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1552.368860] Lustre: lustre-MDT0000-mdc-ffff91c318adb800: Connection to lustre-MDT0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1556.158395] LustreError: 36922:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff91c318adb800: can't stat MDS #0: rc = -19 [ 1557.547925] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1564.665970] LustreError: MGC192.168.206.126@tcp: Connection to MGS (at 192.168.206.126@tcp) was lost; in progress operations using this service will fail [ 1564.690351] Lustre: Evicted from MGS (at 192.168.206.126@tcp) after server handle changed from 0x2b6ae59f1bae6c5f to 0x2b6ae59f1bae6f0d [ 1564.698793] Lustre: MGC192.168.206.126@tcp: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 1565.737716] LustreError: lustre-MDT0000-mdc-ffff91c318adb800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1565.755604] Lustre: lustre-MDT0000-mdc-ffff91c318adb800: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 1570.906761] Lustre: DEBUG MARKER: Wait for df (36922) ... [ 1572.422428] Lustre: DEBUG MARKER: done [ 1574.553228] Lustre: Unmounted lustre-client [ 1601.200212] Key type lgssc unregistered [ 1601.449676] LNet: 37936:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1601.457496] LNetError: 37936:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1601.479848] LNet: Removed LNI 192.168.206.26@tcp [ 1602.273243] Key type .llcrypt unregistered [ 1602.278688] Key type ._llcrypt unregistered [ 1633.234893] Key type ._llcrypt registered [ 1633.236958] Key type .llcrypt registered [ 1634.511246] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 09:18:44 (1790947124) [ 1637.075202] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1637.163412] alg: No test for adler32 (adler32-zlib) [ 1638.218538] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 1638.509227] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 1640.224315] Key type lgssc registered [ 1641.610545] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1688.729655] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1694.633712] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1717.463513] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1720.254603] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 1725.042606] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-10-02 9h20m14s [ 1726.699871] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1733.905697] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1736.226889] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1756.640369] Lustre: 42100:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790947227/real 1790947227] req@0000000097c0bac7 x1877944176745216/t0(0) o101->lustre-MDT0000-mdc-ffff91c3062ae000@192.168.206.126@tcp:12/10 lens 576/1152 e 0 to 1 dl 1790947247 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1756.672118] Lustre: lustre-MDT0000-mdc-ffff91c3062ae000: Connection to lustre-MDT0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1756.705106] Lustre: lustre-MDT0000-mdc-ffff91c3062ae000: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 1778.127360] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1781.307061] Lustre: DEBUG MARKER: done [ 1785.980781] Lustre: Unmounted lustre-client [ 1812.909514] Key type lgssc unregistered [ 1813.097168] LNet: 42981:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1813.104265] LNetError: 42981:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1813.115161] LNet: Removed LNI 192.168.206.26@tcp [ 1813.648371] Key type .llcrypt unregistered [ 1813.651467] Key type ._llcrypt unregistered [ 1844.924972] Key type ._llcrypt registered [ 1844.926425] Key type .llcrypt registered [ 1846.311859] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 09:22:15 (1790947335) [ 1848.191571] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1849.866566] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 09:22:19 (1790947339) [ 1854.295982] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1854.335161] alg: No test for adler32 (adler32-zlib) [ 1855.357764] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 1855.576587] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 1857.264474] Key type lgssc registered [ 1858.536106] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1883.858983] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 09:22:53 (1790947373) [ 1912.510521] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1917.690325] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1936.669262] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1939.175688] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 1942.100975] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1944.744728] Lustre: Unmounted lustre-client [ 1960.620310] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2007.292702] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2011.833697] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2012.311605] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 2015.800539] Lustre: Unmounted lustre-client [ 2075.193518] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2081.944153] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2082.560476] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 2085.484317] Lustre: Unmounted lustre-client [ 2099.760432] Lustre: DEBUG MARKER: files compared the same [ 2118.536186] Key type lgssc unregistered [ 2118.714290] LNet: 50618:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2118.723841] LNetError: 50618:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2118.732536] LNet: Removed LNI 192.168.206.26@tcp [ 2119.189748] Key type .llcrypt unregistered [ 2119.192068] Key type ._llcrypt unregistered [ 2129.330953] Key type ._llcrypt registered [ 2129.332507] Key type .llcrypt registered [ 2130.405749] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 09:27:00 (1790947620) [ 2131.994071] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2132.029843] alg: No test for adler32 (adler32-zlib) [ 2133.004733] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 2133.172924] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 2134.832348] Key type lgssc registered [ 2135.676764] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2189.444451] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2194.619752] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2212.383811] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2214.642152] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 2217.948198] Lustre: Unmounted lustre-client [ 2244.251886] Key type lgssc unregistered [ 2244.451304] LNet: 54215:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2244.464587] LNetError: 54215:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2244.490140] LNet: Removed LNI 192.168.206.26@tcp [ 2245.113149] Key type .llcrypt unregistered [ 2245.117222] Key type ._llcrypt unregistered [ 2258.681509] Key type ._llcrypt registered [ 2258.683916] Key type .llcrypt registered [ 2259.794248] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 09:29:09 (1790947749) [ 2261.711775] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2261.726343] alg: No test for adler32 (adler32-zlib) [ 2262.771799] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 2263.010706] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 2264.672313] Key type lgssc registered [ 2265.636407] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2345.218974] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2376.348743] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2381.637410] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2416.055588] Key type lgssc unregistered [ 2416.354901] LNet: 57717:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2416.363362] LNetError: 57717:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2416.377262] LNet: Removed LNI 192.168.206.26@tcp [ 2417.010212] Key type .llcrypt unregistered [ 2417.012531] Key type ._llcrypt unregistered [ 2429.972995] Key type ._llcrypt registered [ 2429.974539] Key type .llcrypt registered [ 2431.278042] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 09:32:00 (1790947920) [ 2434.312315] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2434.353658] alg: No test for adler32 (adler32-zlib) [ 2435.367290] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 2435.546430] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 2437.186120] Key type lgssc registered [ 2438.467343] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2503.097271] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 2510.011671] Lustre: Unmounted lustre-client [ 2545.983941] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 09:33:55 (1790948035) [ 2654.160692] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2674.229980] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 2681.228969] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2681.238735] LustreError: 64213:0:(file.c:252:ll_close_inode_openhandle()) lustre-clilmv-ffff91c3125aa800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2681.262425] Lustre: 58708:0:(llite_lib.c:4343:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.126@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2691.668296] Lustre: Unmounted lustre-client [ 2734.626562] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 09:37:04 (1790948224) [ 2745.596835] Key type lgssc unregistered [ 2745.935129] LNet: 65423:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2745.944855] LNetError: 65423:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2745.960133] LNet: Removed LNI 192.168.206.26@tcp [ 2746.740915] Key type .llcrypt unregistered [ 2746.747951] Key type ._llcrypt unregistered [ 2758.238620] Key type ._llcrypt registered [ 2758.242308] Key type .llcrypt registered [ 2758.720438] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2758.748125] alg: No test for adler32 (adler32-zlib) [ 2759.851148] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 2760.059117] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 2761.720402] Key type lgssc registered [ 2763.047975] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2809.905058] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2815.513732] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2835.715942] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2837.429922] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 2840.916633] Lustre: Unmounted lustre-client [ 2872.306406] Key type lgssc unregistered [ 2872.559050] LNet: 68449:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2872.576679] LNetError: 68449:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2872.595949] LNet: Removed LNI 192.168.206.26@tcp [ 2873.238644] Key type .llcrypt unregistered [ 2873.241052] Key type ._llcrypt unregistered [ 2883.271982] Key type ._llcrypt registered [ 2883.280227] Key type .llcrypt registered [ 2883.949358] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2883.977815] alg: No test for adler32 (adler32-zlib) [ 2885.094112] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 2885.330364] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 2887.001305] Key type lgssc registered [ 2888.150499] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2995.826641] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3001.517089] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3024.052227] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3026.761854] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 3028.936113] Lustre: Unmounted lustre-client [ 3054.073366] Key type lgssc unregistered [ 3054.319678] LNet: 71899:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3054.326818] LNetError: 71899:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3054.361830] LNet: Removed LNI 192.168.206.26@tcp [ 3055.082189] Key type .llcrypt unregistered [ 3055.090930] Key type ._llcrypt unregistered [ 3071.940773] Key type ._llcrypt registered [ 3071.945726] Key type .llcrypt registered [ 3073.524682] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 09:42:42 (1790948562) [ 3076.137478] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3076.185259] alg: No test for adler32 (adler32-zlib) [ 3077.396608] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 3077.741115] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 3079.464269] Key type lgssc registered [ 3080.902609] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3132.665248] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3138.332616] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3158.135987] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3160.053685] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 3168.107157] Lustre: Unmounted lustre-client [ 3168.588205] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 3171.343433] Lustre: Unmounted lustre-client [ 3198.895764] Key type lgssc unregistered [ 3199.582767] LNet: 75601:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3199.595874] LNetError: 75601:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3199.638118] LNet: Removed LNI 192.168.206.26@tcp [ 3200.771276] Key type .llcrypt unregistered [ 3200.773704] Key type ._llcrypt unregistered [ 3215.416953] Key type ._llcrypt registered [ 3215.419469] Key type .llcrypt registered [ 3215.836924] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3215.852596] alg: No test for adler32 (adler32-zlib) [ 3217.134373] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 3217.336426] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 3218.976582] Key type lgssc registered [ 3220.122485] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3268.606496] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3275.023576] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3296.097804] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3297.956569] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 3302.230778] Lustre: Unmounted lustre-client [ 3330.238501] Key type lgssc unregistered [ 3330.536176] LNet: 78651:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3330.542428] LNetError: 78651:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3330.562420] LNet: Removed LNI 192.168.206.26@tcp [ 3331.380704] Key type .llcrypt unregistered [ 3331.388170] Key type ._llcrypt unregistered [ 3345.617533] Key type ._llcrypt registered [ 3345.619726] Key type .llcrypt registered [ 3346.712210] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 09:47:16 (1790948836) [ 3349.309245] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3349.339483] alg: No test for adler32 (adler32-zlib) [ 3350.321756] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 3350.549309] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 3352.304654] Key type lgssc registered [ 3353.481445] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3399.018568] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3404.266077] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3427.076091] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3428.912738] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 3434.845296] Lustre: lustre: root_squash is set to 0:0 [ 3443.206775] Lustre: lustre: nosquash_nids is cleared [ 3443.217666] Lustre: lustre: root_squash is set to 500:500 [ 3464.727916] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.26@tcp 192.168.0.[2,10]@tcp [ 3473.974806] Lustre: lustre: nosquash_nids set to 192.168.206.26/24@tcp [ 3477.801996] Lustre: Unmounted lustre-client [ 3505.340538] Key type lgssc unregistered [ 3505.606053] LNet: 82653:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3505.612449] LNetError: 82653:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3505.624863] LNet: Removed LNI 192.168.206.26@tcp [ 3506.454620] Key type .llcrypt unregistered [ 3506.455899] Key type ._llcrypt unregistered [ 3521.798155] Key type ._llcrypt registered [ 3521.800968] Key type .llcrypt registered [ 3523.166538] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 09:50:12 (1790949012) [ 3525.812159] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3527.828340] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 09:50:17 (1790949017) [ 3530.212308] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3530.241948] alg: No test for adler32 (adler32-zlib) [ 3531.333377] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 3531.681512] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 3533.400252] Key type lgssc registered [ 3534.668621] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3584.114690] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3589.762988] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3610.374865] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3611.938328] Lustre: lustre: root_squash is set to 500:500 [ 3611.955287] Lustre: lustre: nosquash_nids set to 192.168.206.26/24@tcp [ 3613.122186] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 3618.529633] Lustre: Unmounted lustre-client [ 3645.047332] Key type lgssc unregistered [ 3645.299253] LNet: 86629:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3645.308499] LNetError: 86629:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3645.325599] LNet: Removed LNI 192.168.206.26@tcp [ 3645.953756] Key type .llcrypt unregistered [ 3645.956404] Key type ._llcrypt unregistered [ 3659.940055] Key type ._llcrypt registered [ 3659.941382] Key type .llcrypt registered [ 3661.494453] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3663.066285] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 09:52:32 (1790949152) [ 3680.676894] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3680.716694] alg: No test for adler32 (adler32-zlib) [ 3682.019414] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 3682.157544] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 3683.856250] Key type lgssc registered [ 3685.349770] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3771.822872] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3778.122860] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3807.696357] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3882.629338] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3888.605310] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3909.603204] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3922.040281] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 3957.215762] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff91c306a63000.ost_server_uuid 50 [ 3958.641159] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff91c306a63000.ost_server_uuid in IDLE state after 0 sec [ 3959.410270] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 3962.650492] Lustre: Unmounted lustre-client [ 3963.955210] Lustre: Unmounted lustre-client [ 4010.244914] Key type lgssc unregistered [ 4010.504489] LNet: 94311:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4010.509623] LNetError: 94311:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4010.524858] LNet: Removed LNI 192.168.206.26@tcp [ 4011.332135] Key type .llcrypt unregistered [ 4011.334471] Key type ._llcrypt unregistered [ 4043.475950] Key type ._llcrypt registered [ 4043.481352] Key type .llcrypt registered [ 4044.681335] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 09:58:54 (1790949534) [ 4063.309892] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4063.321733] alg: No test for adler32 (adler32-zlib) [ 4064.317994] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 4064.572977] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 4066.268190] Key type lgssc registered [ 4067.504916] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4151.214739] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4157.291819] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4184.293395] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4187.070415] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 4208.609311] Lustre: 95680:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790949683/real 1790949683] req@00000000cc7ace55 x1877946720589056/t0(0) o400->lustre-OST0000-osc-ffff91c3102c3000@192.168.206.126@tcp:28/4 lens 224/224 e 0 to 1 dl 1790949699 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4208.662769] Lustre: lustre-OST0000-osc-ffff91c3102c3000: Connection to lustre-OST0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4212.897597] Lustre: 95681:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790949688/real 1790949688] req@00000000ad9a88df x1877946720589568/t0(0) o400->lustre-OST0000-osc-ffff91c3102c3000@192.168.206.126@tcp:28/4 lens 224/224 e 0 to 1 dl 1790949704 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4218.016558] Lustre: 95681:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790949693/real 1790949693] req@0000000081e4b0d8 x1877946720590080/t0(0) o400->lustre-OST0000-osc-ffff91c3102c3000@192.168.206.126@tcp:28/4 lens 224/224 e 0 to 1 dl 1790949709 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4218.893976] Lustre: lustre-OST0000-osc-ffff91c3102c3000: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 4223.072525] Lustre: 95681:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790949698/real 1790949698] req@000000003996f24d x1877946720590592/t0(0) o400->lustre-OST0000-osc-ffff91c3102c3000@192.168.206.126@tcp:28/4 lens 224/224 e 0 to 1 dl 1790949714 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4223.997727] Lustre: lustre-MDT0000-mdc-ffff91c3102c3000: Connection to lustre-MDT0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4240.352857] Lustre: 95681:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790949715/real 1790949715] req@0000000081e4b0d8 x1877946720592896/t0(0) o400->MGC192.168.206.126@tcp@192.168.206.126@tcp:26/25 lens 224/224 e 0 to 1 dl 1790949731 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4240.389944] LustreError: MGC192.168.206.126@tcp: Connection to MGS (at 192.168.206.126@tcp) was lost; in progress operations using this service will fail [ 4240.425578] Lustre: Evicted from MGS (at 192.168.206.126@tcp) after server handle changed from 0xea38cd7602c7066b to 0xea38cd7602c708fd [ 4240.447207] Lustre: MGC192.168.206.126@tcp: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 4245.436826] Lustre: lustre-MDT0000-mdc-ffff91c3102c3000: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 4250.927128] Lustre: Unmounted lustre-client [ 4289.147666] Key type lgssc unregistered [ 4289.401934] LNet: 100005:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4289.410213] LNetError: 100005:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4289.431879] LNet: Removed LNI 192.168.206.26@tcp [ 4290.124356] Key type .llcrypt unregistered [ 4290.131793] Key type ._llcrypt unregistered [ 4306.042174] Key type ._llcrypt registered [ 4306.046080] Key type .llcrypt registered [ 4307.508221] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 10:03:17 (1790949797) [ 4322.412761] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4322.423634] alg: No test for adler32 (adler32-zlib) [ 4323.465711] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 4323.721808] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 4325.441117] Key type lgssc registered [ 4327.282063] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4366.170599] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4472.467135] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4478.475861] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4502.316460] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4505.136160] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 4507.265413] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4509.151937] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 10:06:38 (1790949998) [ 4754.996807] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4765.360444] Lustre: Unmounted lustre-client [ 4885.955674] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4891.912913] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4916.480731] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4976.431705] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:14:26 (1790950466) [ 5076.951956] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5083.349243] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5106.640728] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5107.268488] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 5111.532084] Lustre: Unmounted lustre-client [ 5143.255926] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:17:12 (1790950632) [ 5237.141579] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5242.328513] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5269.577349] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5270.343790] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 5275.637806] Lustre: Unmounted lustre-client [ 5312.825972] Key type lgssc unregistered [ 5313.169444] LNet: 123051:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5313.176748] LNetError: 123051:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5313.189038] LNet: Removed LNI 192.168.206.26@tcp [ 5313.989431] Key type .llcrypt unregistered [ 5313.994854] Key type ._llcrypt unregistered [ 5331.272435] Key type ._llcrypt registered [ 5331.275032] Key type .llcrypt registered [ 5332.504795] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 10:20:22 (1790950822) [ 5335.349123] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5335.545219] alg: No test for adler32 (adler32-zlib) [ 5336.706629] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 5337.062124] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 5338.784991] Key type lgssc registered [ 5340.320678] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5390.902160] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5395.690874] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5417.372391] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5420.084494] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 5433.737626] Lustre: Unmounted lustre-client [ 5460.024199] Key type lgssc unregistered [ 5460.241668] LNet: 126663:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5460.265155] LNetError: 126663:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5460.283374] LNet: Removed LNI 192.168.206.26@tcp [ 5460.935660] Key type .llcrypt unregistered [ 5460.938113] Key type ._llcrypt unregistered [ 5475.189497] Key type ._llcrypt registered [ 5475.194481] Key type .llcrypt registered [ 5476.487699] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 10:22:46 (1790950966) [ 5478.774263] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5478.812795] alg: No test for adler32 (adler32-zlib) [ 5479.796298] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 5479.976913] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 5481.640405] Key type lgssc registered [ 5482.655430] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5529.219533] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5534.004542] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5554.956537] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5556.584747] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 5561.834189] Lustre: lustre-OST0000-osc-ffff91c3124d5000: Connection to lustre-OST0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5573.456997] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff91c3124d5000.ost_server_uuid 50 [ 5575.039243] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5585.545947] Lustre: Unmounted lustre-client [ 5606.474847] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 10:24:56 (1790951096) [ 5642.106475] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5648.745445] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5670.920507] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5694.638892] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5695.233179] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 5700.583041] Lustre: lustre-OST0000-osc-ffff91c3125a9000: Connection to lustre-OST0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5727.359145] Lustre: Unmounted lustre-client [ 5787.739817] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 10:27:57 (1790951277) [ 5823.650403] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5829.999374] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5855.293747] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5881.196744] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5881.940795] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 5886.976806] Lustre: lustre-OST0000-osc-ffff91c305122000: Connection to lustre-OST0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5903.533222] Lustre: Unmounted lustre-client [ 5952.089539] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 10:30:41 (1790951441) [ 6049.321910] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6056.113625] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6083.280591] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6175.086361] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6182.168168] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6206.941097] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6240.506386] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 6282.181654] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6288.138853] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 4 sec [ 6290.244970] Lustre: Unmounted lustre-client [ 6321.512431] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 10:36:51 (1790951811) [ 6354.340567] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6359.775655] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6380.277959] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6415.987973] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6447.226283] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 6491.850261] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6493.146083] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6504.562696] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6514.911624] Lustre: Unmounted lustre-client [ 6568.126540] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 10:40:57 (1790952057) [ 6604.715515] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6610.638700] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6635.191623] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6635.996913] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 6659.658844] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6661.137531] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6674.385541] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff91c306d4a800.ost_server_uuid 50 [ 6676.276282] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff91c306d4a800.ost_server_uuid in IDLE state after 0 sec [ 6679.341735] Lustre: Unmounted lustre-client [ 6679.702416] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6679.709137] Lustre: Skipped 3 previous similar messages [ 6679.835620] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 6681.175254] LustreError: 150148:0:(sec.c:409:import_sec_validate_get()) import 0000000071fc546b (NEW) with no sec [ 6745.083979] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 10:43:54 (1790952234) [ 6784.398520] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6790.866583] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6812.607614] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6831.725582] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6832.168279] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6832.288450] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 6845.034561] Lustre: Unmounted lustre-client [ 6845.042024] Lustre: Skipped 1 previous similar message [ 6884.590855] Key type lgssc unregistered [ 6884.912517] LNet: 153565:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6884.942937] LNetError: 153565:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6884.981928] LNet: Removed LNI 192.168.206.26@tcp [ 6886.164792] Key type .llcrypt unregistered [ 6886.172546] Key type ._llcrypt unregistered [ 6905.443933] Key type ._llcrypt registered [ 6905.451036] Key type .llcrypt registered [ 6906.544197] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 10:46:36 (1790952396) [ 6907.773803] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6907.795196] alg: No test for adler32 (adler32-zlib) [ 6908.841338] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 6909.096318] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 6910.800397] Key type lgssc registered [ 6911.952787] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6960.255396] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6965.605704] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6984.473662] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7006.671540] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7008.425539] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7009.753244] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 7014.399515] LustreError: lustre-MDT0001-mdc-ffff91c302d88000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7014.449798] Lustre: lustre-MDT0001-mdc-ffff91c302d88000: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 7022.242674] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7023.979216] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7050.258734] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7053.726514] Lustre: Unmounted lustre-client [ 7082.458444] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 10:49:32 (1790952572) [ 7175.720492] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7181.522301] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7204.795498] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7205.560257] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 7237.538762] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7239.398376] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7252.242919] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7262.566271] Lustre: Unmounted lustre-client [ 7295.350829] Key type lgssc unregistered [ 7295.598678] LNet: 163192:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7295.609921] LNetError: 163192:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7296.683457] LNet: Removed LNI 192.168.206.26@tcp [ 7297.255803] Key type .llcrypt unregistered [ 7297.258304] Key type ._llcrypt unregistered [ 7327.059724] Key type ._llcrypt registered [ 7327.064639] Key type .llcrypt registered [ 7328.202239] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 10:53:38 (1790952818) [ 7330.953534] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7330.999257] alg: No test for adler32 (adler32-zlib) [ 7332.034883] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 7332.321360] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 7334.033204] Key type lgssc registered [ 7335.363794] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7386.242811] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7391.583542] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7410.010659] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7411.806708] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 7453.410606] Lustre: Unmounted lustre-client [ 7497.942556] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7498.948411] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 7537.837754] Lustre: Unmounted lustre-client [ 7573.337538] Key type lgssc unregistered [ 7573.614673] LNet: 167650:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7573.627660] LNetError: 167650:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7574.697487] LNet: Removed LNI 192.168.206.26@tcp [ 7575.490931] Key type .llcrypt unregistered [ 7575.493076] Key type ._llcrypt unregistered [ 7591.182348] Key type ._llcrypt registered [ 7591.183890] Key type .llcrypt registered [ 7592.883762] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 10:58:02 (1790953082) [ 7595.768134] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7595.861604] alg: No test for adler32 (adler32-zlib) [ 7597.053923] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 7597.355762] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 7599.146383] Key type lgssc registered [ 7600.740867] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7660.635074] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7666.766640] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7687.498609] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7700.007439] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 7716.736639] Lustre: Unmounted lustre-client [ 7746.836570] Key type lgssc unregistered [ 7747.131169] LNet: 171423:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7747.147175] LNetError: 171423:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7747.192321] LNet: Removed LNI 192.168.206.26@tcp [ 7747.855479] Key type .llcrypt unregistered [ 7747.857765] Key type ._llcrypt unregistered [ 7761.309927] Key type ._llcrypt registered [ 7761.312810] Key type .llcrypt registered [ 7761.811483] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7761.834510] alg: No test for adler32 (adler32-zlib) [ 7762.983326] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 7763.362368] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 7765.120258] Key type lgssc registered [ 7766.550704] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7815.486765] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7820.964075] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7839.291497] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7840.794143] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 7846.787492] Lustre: Unmounted lustre-client [ 7872.466017] Key type lgssc unregistered [ 7872.693960] LNet: 174508:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7872.702905] LNetError: 174508:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7872.718758] LNet: Removed LNI 192.168.206.26@tcp [ 7873.498862] Key type .llcrypt unregistered [ 7873.501423] Key type ._llcrypt unregistered [ 7890.022177] Key type ._llcrypt registered [ 7890.023509] Key type .llcrypt registered [ 7891.468954] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 11:03:01 (1790953381) [ 7894.002174] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7894.148232] alg: No test for adler32 (adler32-zlib) [ 7895.208918] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 7895.596109] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 7897.432236] Key type lgssc registered [ 7898.823383] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7943.697782] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7949.071213] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7972.850862] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7974.738854] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 7995.034797] Lustre: Unmounted lustre-client [ 8023.911989] Key type lgssc unregistered [ 8024.162734] LNet: 178276:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8024.180693] LNetError: 178276:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8024.200704] LNet: Removed LNI 192.168.206.26@tcp [ 8025.102766] Key type .llcrypt unregistered [ 8025.109840] Key type ._llcrypt unregistered [ 8037.353613] Key type ._llcrypt registered [ 8037.364991] Key type .llcrypt registered [ 8037.545113] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8037.556948] alg: No test for adler32 (adler32-zlib) [ 8038.610424] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 8038.789573] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 8040.488917] Key type lgssc registered [ 8041.580799] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8093.272818] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8100.098074] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8126.177630] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8129.176695] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 8138.239251] Lustre: Unmounted lustre-client [ 8166.446763] Key type lgssc unregistered [ 8166.628922] LNet: 181353:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8166.638156] LNetError: 181353:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8166.656084] LNet: Removed LNI 192.168.206.26@tcp [ 8167.222507] Key type .llcrypt unregistered [ 8167.224209] Key type ._llcrypt unregistered [ 8182.308554] Key type ._llcrypt registered [ 8182.313879] Key type .llcrypt registered [ 8183.450701] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 11:07:53 (1790953673) [ 8206.029756] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8206.056088] alg: No test for adler32 (adler32-zlib) [ 8207.086078] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 8207.260027] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 8208.921122] Key type lgssc registered [ 8210.241451] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8282.212815] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8287.062212] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8307.159592] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8355.041339] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 11:10:45 (1790953845) [ 8385.130046] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8390.027701] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8407.323602] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8409.893442] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 8414.191811] Lustre: Unmounted lustre-client [ 8439.731748] Key type lgssc unregistered [ 8439.998880] LNet: 188467:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8440.008301] LNetError: 188467:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8440.029083] LNet: Removed LNI 192.168.206.26@tcp [ 8440.666825] Key type .llcrypt unregistered [ 8440.669329] Key type ._llcrypt unregistered [ 8454.581996] Key type ._llcrypt registered [ 8454.584920] Key type .llcrypt registered [ 8456.074973] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8458.525478] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 11:12:27 (1790953947) [ 8477.545262] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8477.561578] alg: No test for adler32 (adler32-zlib) [ 8478.656519] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 8478.997290] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 8480.712520] Key type lgssc registered [ 8482.194852] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8569.191737] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8574.483806] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8597.347714] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8617.457334] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8619.098117] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 8639.718995] Lustre: Unmounted lustre-client [ 8763.305363] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8768.291485] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8792.174906] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8840.243560] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 11:18:50 (1790954330) [ 8841.843537] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8843.488435] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 11:18:53 (1790954333) [ 8937.944183] Key type lgssc unregistered [ 8938.131897] LNet: 199927:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8938.141667] LNetError: 199927:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8938.155047] LNet: Removed LNI 192.168.206.26@tcp [ 8938.669530] Key type .llcrypt unregistered [ 8938.671066] Key type ._llcrypt unregistered [ 8954.675736] Key type ._llcrypt registered [ 8954.677893] Key type .llcrypt registered [ 8955.966678] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 11:20:45 (1790954445) [ 8998.240607] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8998.254863] alg: No test for adler32 (adler32-zlib) [ 8999.428938] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 8999.715943] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 9001.392538] Key type lgssc registered [ 9002.581750] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9050.310615] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9055.322665] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9085.084884] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9112.644260] Key type lgssc unregistered [ 9112.816706] LNet: 203678:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9112.821522] LNetError: 203678:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9112.841542] LNet: Removed LNI 192.168.206.26@tcp [ 9113.428704] Key type .llcrypt unregistered [ 9113.437381] Key type ._llcrypt unregistered [ 9128.180561] Key type ._llcrypt registered [ 9128.182530] Key type .llcrypt registered [ 9128.945951] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 11:23:39 (1790954619) [ 9130.854079] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9130.873114] alg: No test for adler32 (adler32-zlib) [ 9131.870759] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 9132.027596] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 9133.665427] Key type lgssc registered [ 9134.647521] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9185.342521] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9190.129935] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9210.869859] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9213.469384] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 9223.667157] Lustre: lustre-MDT0000-mdc-ffff91c31130a000: Connection to lustre-MDT0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9233.909964] Lustre: lustre-MDT0001-mdc-ffff91c31130a000: Connection to lustre-MDT0001 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9244.192154] Lustre: 204674:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790954719/real 1790954719] req@00000000af8a77b6 x1877952034848896/t0(0) o400->MGC192.168.206.126@tcp@192.168.206.126@tcp:26/25 lens 224/224 e 0 to 1 dl 1790954735 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9244.222759] LustreError: MGC192.168.206.126@tcp: Connection to MGS (at 192.168.206.126@tcp) was lost; in progress operations using this service will fail [ 9254.506157] Lustre: Evicted from MGS (at 192.168.206.126@tcp) after server handle changed from 0x37cf15e4b1e494ba to 0x37cf15e4b1e4b027 [ 9254.533364] Lustre: MGC192.168.206.126@tcp: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 9279.493291] LustreError: lustre-MDT0000-mdc-ffff91c31130a000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9279.562986] Lustre: lustre-MDT0000-mdc-ffff91c31130a000: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 9287.193342] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9288.634973] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9294.219266] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9295.486261] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9297.488207] Lustre: Unmounted lustre-client [ 9323.388369] Key type lgssc unregistered [ 9323.689929] LNet: 208642:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9323.698440] LNetError: 208642:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9323.717815] LNet: Removed LNI 192.168.206.26@tcp [ 9324.476673] Key type .llcrypt unregistered [ 9324.480387] Key type ._llcrypt unregistered [ 9339.249454] Key type ._llcrypt registered [ 9339.251930] Key type .llcrypt registered [ 9340.239347] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 11:27:10 (1790954830) [ 9342.034570] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9342.055890] alg: No test for adler32 (adler32-zlib) [ 9343.139595] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 9343.469901] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 9345.184964] Key type lgssc registered [ 9346.404077] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9395.822135] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9402.804580] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9463.717733] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9471.627778] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9505.882873] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9527.068406] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9582.292889] Key type lgssc unregistered [ 9582.554486] LNet: 213949:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9582.566547] LNetError: 213949:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9582.591208] LNet: Removed LNI 192.168.206.26@tcp [ 9583.228767] Key type .llcrypt unregistered [ 9583.231417] Key type ._llcrypt unregistered [ 9623.659612] Key type ._llcrypt registered [ 9623.662426] Key type .llcrypt registered [ 9625.014104] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 11:31:54 (1790955114) [ 9660.567730] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9660.643534] alg: No test for adler32 (adler32-zlib) [ 9661.711143] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [ 9661.986064] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [ 9663.633083] Key type lgssc registered [ 9664.914592] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9737.134957] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9742.310342] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9765.783856] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9821.011246] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 11:35:10 (1790955310) [ 9829.836621] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 11:35:19 (1790955319) [ 9855.305246] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9859.998437] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9874.935570] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9886.738614] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [ 9891.414555] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9893.432513] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9894.896818] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9896.382964] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9902.058469] Lustre: lustre-MDT0000-mdc-ffff91c318758800: Connection to lustre-MDT0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9917.419685] LustreError: MGC192.168.206.126@tcp: Connection to MGS (at 192.168.206.126@tcp) was lost; in progress operations using this service will fail [ 9917.448049] Lustre: Evicted from MGS (at 192.168.206.126@tcp) after server handle changed from 0xc8b5653d6295470 to 0xc8b5653d62956e6 [ 9917.459120] Lustre: MGC192.168.206.126@tcp: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 9919.896887] Lustre: lustre-MDT0000-mdc-ffff91c318758800: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 9925.303409] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9926.252560] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9929.603615] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9932.782857] Lustre: lustre-MDT0000-mdc-ffff91c318758800: Connection to lustre-MDT0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9948.128169] Lustre: 215850:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1790955423/real 1790955423] req@00000000964a7549 x1877952590529792/t0(0) o400->MGC192.168.206.126@tcp@192.168.206.126@tcp:26/25 lens 224/224 e 0 to 1 dl 1790955439 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9948.155911] LustreError: MGC192.168.206.126@tcp: Connection to MGS (at 192.168.206.126@tcp) was lost; in progress operations using this service will fail [ 9953.712769] Lustre: lustre-MDT0000-mdc-ffff91c318758800: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 9958.315525] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9958.825620] Lustre: Evicted from MGS (at 192.168.206.126@tcp) after server handle changed from 0xc8b5653d62956e6 to 0xc8b5653d6295b93 [ 9958.841116] Lustre: MGC192.168.206.126@tcp: Connection restored to 192.168.206.126@tcp (at 192.168.206.126@tcp) [ 9959.442852] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9962.155422] Lustre: Unmounted lustre-client [10015.497814] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10018.992520] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10033.827136] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10044.448268] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [10045.554578] Lustre: Unmounted lustre-client [10063.726451] Key type lgssc unregistered [10063.913732] LNet: 226428:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10063.919504] LNetError: 226428:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10063.940369] LNet: Removed LNI 192.168.206.26@tcp [10064.373995] Key type .llcrypt unregistered [10064.376347] Key type ._llcrypt unregistered [10076.937137] Key type ._llcrypt registered [10076.938633] Key type .llcrypt registered [10078.005165] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 11:39:27 (1790955567) [10081.170784] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10081.184634] alg: No test for adler32 (adler32-zlib) [10082.230636] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [10082.438728] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [10084.080216] Key type lgssc registered [10085.035501] Lustre: Echo OBD driver; http://www.lustre.org/ [10123.681309] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10127.403661] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10141.610678] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10152.466064] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [10156.648631] Lustre: Unmounted lustre-client [10208.060346] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10212.163833] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10226.173881] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10236.954735] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [10244.877428] Lustre: Unmounted lustre-client [10303.012837] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10307.336452] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10321.948623] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10332.689581] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [10333.660355] Lustre: Unmounted lustre-client [10351.368453] Key type lgssc unregistered [10351.603489] LNet: 233479:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10351.611492] LNetError: 233479:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10351.622833] LNet: Removed LNI 192.168.206.26@tcp [10352.158756] Key type .llcrypt unregistered [10352.161596] Key type ._llcrypt unregistered [10363.494662] Key type ._llcrypt registered [10363.497550] Key type .llcrypt registered [10364.290520] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 11:44:14 (1790955854) [10366.383419] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10366.404120] alg: No test for adler32 (adler32-zlib) [10367.359911] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [10367.510611] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [10369.144204] Key type lgssc registered [10369.870221] Lustre: Echo OBD driver; http://www.lustre.org/ [10396.492650] Key type lgssc unregistered [10396.674388] LNet: 235808:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10396.683608] LNetError: 235808:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10396.698581] LNet: Removed LNI 192.168.206.26@tcp [10397.206520] Key type .llcrypt unregistered [10397.209341] Key type ._llcrypt unregistered [10414.053711] Key type ._llcrypt registered [10414.057979] Key type .llcrypt registered [10414.275637] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10414.283429] alg: No test for adler32 (adler32-zlib) [10415.203045] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [10415.386336] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [10417.000274] Key type lgssc registered [10417.710273] Lustre: Echo OBD driver; http://www.lustre.org/ [10478.057718] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10481.831767] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10496.299562] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10535.477978] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10536.697550] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 11:47:06 (1790956026) [10558.459336] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10561.901899] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10575.359447] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10589.600692] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10592.163596] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [10597.356241] Lustre: lustre-OST0001-osc-ffff91c3102c1000: Connection to lustre-OST0001 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [10601.564892] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10611.886299] Lustre: Unmounted lustre-client [10639.506662] Key type lgssc unregistered [10639.677286] LNet: 242921:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10639.682346] LNetError: 242921:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10639.693137] LNet: Removed LNI 192.168.206.26@tcp [10640.124568] Key type .llcrypt unregistered [10640.125880] Key type ._llcrypt unregistered [10659.529541] Key type ._llcrypt registered [10659.533249] Key type .llcrypt registered [10660.307761] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 11:49:10 (1790956150) [10668.232472] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10668.245773] alg: No test for adler32 (adler32-zlib) [10669.227589] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [10669.352724] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [10670.968272] Key type lgssc registered [10671.763127] Lustre: Echo OBD driver; http://www.lustre.org/ [10702.514140] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10706.131321] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10732.445745] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 11:50:22 (1790956222) [10754.712868] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10758.214338] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10771.901299] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10774.353567] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [10780.473301] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [10782.082279] Lustre: Unmounted lustre-client [10856.934097] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10859.942611] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10904.312414] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10909.722854] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [10911.556239] Lustre: Unmounted lustre-client [10935.643393] Key type lgssc unregistered [10935.811338] LNet: 250624:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10935.814696] LNetError: 250624:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10935.836189] LNet: Removed LNI 192.168.206.26@tcp [10936.404909] Key type .llcrypt unregistered [10936.407066] Key type ._llcrypt unregistered [10953.966295] Key type ._llcrypt registered [10953.969996] Key type .llcrypt registered [10954.215480] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10954.229662] alg: No test for adler32 (adler32-zlib) [10955.164210] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [10955.299962] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [10956.944421] Key type lgssc registered [10957.718739] Lustre: Echo OBD driver; http://www.lustre.org/ [11005.971077] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11009.437489] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11026.924852] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11059.734753] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11060.962453] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 11:55:51 (1790956551) [11084.821875] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11089.006565] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11102.865376] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11111.467184] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [11113.357767] Lustre: Unmounted lustre-client [11143.218604] Key type lgssc unregistered [11143.369479] LNet: 257256:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11143.374468] LNetError: 257256:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11143.390367] LNet: Removed LNI 192.168.206.26@tcp [11143.791469] Key type .llcrypt unregistered [11143.793286] Key type ._llcrypt unregistered [11152.697310] Key type ._llcrypt registered [11152.698942] Key type .llcrypt registered [11153.615401] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11154.670417] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 11:57:24 (1790956644) [11160.883918] Key type .llcrypt unregistered [11160.885808] Key type ._llcrypt unregistered [11166.617068] Key type ._llcrypt registered [11166.622124] Key type .llcrypt registered [11166.849220] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11166.859631] alg: No test for adler32 (adler32-zlib) [11167.821079] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [11167.957328] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [11169.592260] Key type lgssc registered [11170.470632] Lustre: Echo OBD driver; http://www.lustre.org/ [11204.927581] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11218.946640] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [11219.797201] Lustre: Unmounted lustre-client [11236.521218] Key type lgssc unregistered [11236.680486] LNet: 260714:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11236.689483] LNetError: 260714:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11236.703514] LNet: Removed LNI 192.168.206.26@tcp [11237.066327] Key type .llcrypt unregistered [11237.068080] Key type ._llcrypt unregistered [11245.541376] Key type ._llcrypt registered [11245.543581] Key type .llcrypt registered [11246.290777] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 11:58:56 (1790956736) [11247.468877] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11247.488068] alg: No test for adler32 (adler32-zlib) [11248.389760] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [11248.515452] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [11250.136233] Key type lgssc registered [11250.828651] Lustre: Echo OBD driver; http://www.lustre.org/ [11317.426902] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11332.593925] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11335.120553] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11336.417731] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [11337.206448] Lustre: Unmounted lustre-client [11355.780201] Key type lgssc unregistered [11355.904994] LNet: 264261:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11355.909132] LNetError: 264261:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11355.920122] LNet: Removed LNI 192.168.206.26@tcp [11356.204178] Key type .llcrypt unregistered [11356.206196] Key type ._llcrypt unregistered [11362.595217] Key type ._llcrypt registered [11362.596547] Key type .llcrypt registered [11363.140819] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 12:00:53 (1790956853) [11363.937484] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11363.962035] alg: No test for adler32 (adler32-zlib) [11364.859272] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [11364.967479] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [11366.568257] Key type lgssc registered [11367.073475] Lustre: Echo OBD driver; http://www.lustre.org/ [11389.080634] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11391.733387] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11400.649525] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11407.344445] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [11412.450951] Lustre: lustre-MDT0000-mdc-ffff91c3124d1800: Connection to lustre-MDT0000 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [11415.254605] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11415.266040] LustreError: 267435:0:(file.c:6243:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [11415.406771] LustreError: MGC192.168.206.126@tcp: Connection to MGS (at 192.168.206.126@tcp) was lost; in progress operations using this service will fail [11415.431101] Lustre: Unmounted lustre-client [11427.610768] Key type lgssc unregistered [11427.748711] LNet: 267846:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11427.754217] LNetError: 267846:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11427.765335] LNet: Removed LNI 192.168.206.26@tcp [11428.067689] Key type .llcrypt unregistered [11428.070349] Key type ._llcrypt unregistered [11434.304380] Key type ._llcrypt registered [11434.305970] Key type .llcrypt registered [11434.874107] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 12:02:05 (1790956925) [11435.704142] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11435.742532] alg: No test for adler32 (adler32-zlib) [11436.632496] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [11436.755325] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [11438.376323] Key type lgssc registered [11438.992461] Lustre: Echo OBD driver; http://www.lustre.org/ [11460.981454] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11463.466267] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11472.041282] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11478.508541] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [11486.334645] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [11486.869783] Lustre: Unmounted lustre-client [11498.751672] Key type lgssc unregistered [11498.895504] LNet: 271427:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11498.899202] LNetError: 271427:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11498.909066] LNet: Removed LNI 192.168.206.26@tcp [11499.198273] Key type .llcrypt unregistered [11499.201309] Key type ._llcrypt unregistered [11505.169493] Key type ._llcrypt registered [11505.170813] Key type .llcrypt registered [11505.701575] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 12:03:16 (1790956996) [11512.926523] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11512.974994] alg: No test for adler32 (adler32-zlib) [11513.882758] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [11514.001801] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [11515.608225] Key type lgssc registered [11516.134566] Lustre: Echo OBD driver; http://www.lustre.org/ [11563.561330] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11570.149491] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [11588.583654] Lustre: lustre-MDT0001-mdc-ffff91c3124d1800: Connection to lustre-MDT0001 (at 192.168.206.126@tcp) was lost; in progress operations using this service will wait for recovery to complete [11599.776093] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11610.045245] Lustre: Unmounted lustre-client [11635.870415] Key type lgssc unregistered [11635.980884] LNet: 277210:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11635.985402] LNetError: 277210:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11635.998889] LNet: Removed LNI 192.168.206.26@tcp [11636.249956] Key type .llcrypt unregistered [11636.251642] Key type ._llcrypt unregistered [11641.618160] Key type ._llcrypt registered [11641.619188] Key type .llcrypt registered [11642.075749] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 12:05:32 (1790957132) [11642.645717] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [11643.225765] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 12:05:33 (1790957133) [11643.814038] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [11644.436355] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 12:05:35 (1790957135) [11645.102086] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [11645.777931] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 12:05:36 (1790957136) [11646.392355] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [11647.012207] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 12:05:37 (1790957137) [11647.604559] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [11648.212765] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 12:05:38 (1790957138) [11651.438476] Key type .llcrypt unregistered [11651.439908] Key type ._llcrypt unregistered [11653.899806] Key type ._llcrypt registered [11653.901133] Key type .llcrypt registered [11654.087861] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11654.094884] alg: No test for adler32 (adler32-zlib) [11654.962066] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [11655.067130] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [11656.664334] Key type lgssc registered [11657.123306] Lustre: Echo OBD driver; http://www.lustre.org/ [11688.589647] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11690.683551] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11700.002789] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11706.337919] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [11706.957170] Lustre: Unmounted lustre-client [11731.298755] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 12:07:01 (1790957221) [11743.822251] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11746.029431] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11766.699599] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11782.646052] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [11783.045139] Lustre: Unmounted lustre-client [11817.783117] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 12:08:28 (1790957308) [11828.128469] LNet: 1 local NIs in recovery (showing 1): 192.168.206.26@tcp [12406.668464] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12408.488291] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12428.044297] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12474.280082] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 12:19:25 (1790957965) [12478.050589] Key type lgssc unregistered [12478.170741] LNet: 290709:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12478.174592] LNetError: 290709:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12478.184758] LNet: Removed LNI 192.168.206.26@tcp [12478.426828] Key type .llcrypt unregistered [12478.427758] Key type ._llcrypt unregistered [12555.756649] Key type ._llcrypt registered [12555.757836] Key type .llcrypt registered [12555.922384] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12555.953882] alg: No test for adler32 (adler32-zlib) [12556.816356] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [12556.914334] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [12558.512319] Key type lgssc registered [12558.956060] Lustre: Echo OBD driver; http://www.lustre.org/ [12588.836513] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12590.578322] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12598.148410] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12625.059752] Key type lgssc unregistered [12625.169528] LNet: 294398:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12625.172671] LNetError: 294398:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12625.180451] LNet: Removed LNI 192.168.206.26@tcp [12625.422797] Key type .llcrypt unregistered [12625.424385] Key type ._llcrypt unregistered [12653.443224] Key type ._llcrypt registered [12653.444380] Key type .llcrypt registered [12653.860943] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 12:22:24 (1790958144) [12660.190395] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12660.227926] alg: No test for adler32 (adler32-zlib) [12661.092554] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [12661.202339] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [12662.784329] Key type lgssc registered [12663.154741] Lustre: Echo OBD driver; http://www.lustre.org/ [12679.347144] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 12:22:50 (1790958170) [12682.998581] Key type lgssc unregistered [12683.102380] LNet: 297958:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12683.104312] LNetError: 297958:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12683.111475] LNet: Removed LNI 192.168.206.26@tcp [12683.314693] Key type .llcrypt unregistered [12683.315668] Key type ._llcrypt unregistered [12686.526828] Key type ._llcrypt registered [12686.527895] Key type .llcrypt registered [12686.680421] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12686.688385] alg: No test for adler32 (adler32-zlib) [12687.549410] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [12687.642267] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [12689.224181] Key type lgssc registered [12689.585288] Lustre: Echo OBD driver; http://www.lustre.org/ [12709.403647] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12711.170641] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12718.727500] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12804.893076] LNet: Added LNI 192.168.206.26@tcp50 [8/256/0/180] [12805.704942] LNet: Removed LNI 192.168.206.26@tcp [12807.085968] Lustre: 302332:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff91c3041e4800: config has no valid NIDs, force dynamic NIDs [12808.128536] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [12808.175328] Lustre: Unmounted lustre-client [12809.085796] Key type lgssc unregistered [12809.219105] LNet: 302590:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12809.221397] LNetError: 302590:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12809.233310] LNet: Removed LNI 192.168.206.26@tcp50 [12809.436328] Key type .llcrypt unregistered [12809.437474] Key type ._llcrypt unregistered [12819.130624] Key type ._llcrypt registered [12819.131547] Key type .llcrypt registered [12819.275662] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12819.288192] alg: No test for adler32 (adler32-zlib) [12820.140708] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [12820.222512] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [12821.800238] Key type lgssc registered [12822.177396] Lustre: Echo OBD driver; http://www.lustre.org/ [12835.985608] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12837.779441] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12840.099365] LNet: Added LNI 192.168.206.26@tcp50 [8/256/0/180] [12840.344830] LNet: Removed LNI 192.168.206.26@tcp [12841.389654] Lustre: 305283:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff91c302fde000: config has no valid NIDs, force dynamic NIDs [12842.432021] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [12842.578122] Lustre: Unmounted lustre-client [12860.790314] Key type lgssc unregistered [12860.921557] LNet: 306149:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12860.923754] LNetError: 306149:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12860.931472] LNet: Removed LNI 192.168.206.26@tcp50 [12861.137525] Key type .llcrypt unregistered [12861.138732] Key type ._llcrypt unregistered [12864.525468] Key type ._llcrypt registered [12864.526786] Key type .llcrypt registered [12864.992715] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 12:25:55 (1790958355) [12870.744364] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12870.791898] alg: No test for adler32 (adler32-zlib) [12871.658907] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [12871.753720] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [12873.336268] Key type lgssc registered [12873.761193] Lustre: Echo OBD driver; http://www.lustre.org/ [12901.561915] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12903.350745] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12911.356275] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12930.047095] Key type lgssc unregistered [12930.162478] LNet: 310891:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12930.165541] LNetError: 310891:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12930.174665] LNet: Removed LNI 192.168.206.26@tcp [12930.432838] Key type .llcrypt unregistered [12930.433813] Key type ._llcrypt unregistered [12933.806626] Key type ._llcrypt registered [12933.807726] Key type .llcrypt registered [12934.231660] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 12:27:04 (1790958424) [12934.864946] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12934.871168] alg: No test for adler32 (adler32-zlib) [12935.731426] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [12935.823875] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [12937.408218] Key type lgssc registered [12937.798360] Lustre: Echo OBD driver; http://www.lustre.org/ [12955.761597] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12957.615021] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12964.553676] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12975.088454] Lustre: Mounted lustre-client - version 2.17.59_2_gbfaf0e7 [12995.598226] Lustre: Mounted fs15246-client - version 2.17.59_2_gbfaf0e7 [13000.591151] Lustre: Unmounted fs15246-client [13013.371126] Lustre: Unmounted lustre-client [13038.650383] Key type lgssc unregistered [13038.768582] LNet: 315742:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13038.772775] LNetError: 315742:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13038.779742] LNet: Removed LNI 192.168.206.26@tcp [13039.040206] Key type .llcrypt unregistered [13039.042289] Key type ._llcrypt unregistered [13042.746157] Key type ._llcrypt registered [13042.747238] Key type .llcrypt registered [13043.218706] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 12:28:53 (1790958533) [13043.865296] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13043.871891] alg: No test for adler32 (adler32-zlib) [13044.733600] Lustre: Lustre: Build Version: 2.17.59_2_gbfaf0e7 [13044.826823] LNet: Added LNI 192.168.206.26@tcp [8/256/0/180] [13046.416159] Key type lgssc registered [13046.842079] Lustre: Echo OBD driver; http://www.lustre.org/ [13090.543868] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13092.468343] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13100.911243] Lustre: DEBUG MARKER: oleg626-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13140.886683] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 12831 sec ========= 12:30:31 (1790958631) [13141.399945] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 12:30:32 (1790958632) === [13142.457666] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 12:30:33 (1790958633) === [13153.193480] Key type lgssc unregistered [13153.302483] LNet: 324986:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13153.304875] LNetError: 324986:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13153.312456] LNet: Removed LNI 192.168.206.26@tcp [13153.540641] Key type .llcrypt unregistered [13153.541709] Key type ._llcrypt unregistered