[ 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 461837115 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001009] APIC: Switch to symmetric I/O mode setup [ 0.002376] x2apic enabled [ 0.003008] Switched APIC routing to physical x2apic. [ 0.004012] kvm-guest: setup PV IPIs [ 0.007384] ..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.008023] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009010] pid_max: default: 32768 minimum: 301 [ 0.010125] LSM: Security Framework initializing [ 0.011051] Yama: becoming mindful. [ 0.012000] SELinux: Initializing. [ 0.012070] *** VALIDATE selinux *** [ 0.020423] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.024834] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027130] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028099] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029123] *** VALIDATE tmpfs *** [ 0.030449] *** VALIDATE proc *** [ 0.032123] *** VALIDATE cgroup *** [ 0.033009] *** VALIDATE cgroup2 *** [ 0.034258] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035161] 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.037030] Spectre V2 : User space: Vulnerable [ 0.038009] Speculative Store Bypass: Vulnerable [ 0.040790] debug: unmapping init [mem 0xffffffffb7659000-0xffffffffb7660fff] [ 0.042996] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.043662] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.044027] ... version: 2 [ 0.045013] ... bit width: 48 [ 0.046012] ... generic registers: 4 [ 0.047014] ... value mask: 0000ffffffffffff [ 0.048017] ... max period: 00007fffffffffff [ 0.049016] ... fixed-purpose events: 3 [ 0.050016] ... event mask: 000000070000000f [ 0.051337] rcu: Hierarchical SRCU implementation. [ 0.053460] smp: Bringing up secondary CPUs ... [ 0.054509] x86: Booting SMP configuration: [ 0.055021] .... node #0, CPUs: #1 #2 #3 [ 0.061123] smp: Brought up 1 node, 4 CPUs [ 0.063015] smpboot: Max logical packages: 1 [ 0.064015] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.234187] node 0 deferred pages initialised in 168ms [ 0.237205] devtmpfs: initialized [ 0.238220] x86/mm: Memory block size: 128MB [ 0.240312] gcov: version magic: 0x41383552 [ 0.242318] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.243100] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.245466] pinctrl core: initialized pinctrl subsystem [ 0.248282] [ 0.248887] ************************************************************* [ 0.251020] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.253016] ** ** [ 0.255020] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.258019] ** ** [ 0.259010] ** This means that this kernel is built to expose internal ** [ 0.261012] ** IOMMU data structures, which may compromise security on ** [ 0.262025] ** your system. ** [ 0.264014] ** ** [ 0.266022] ** If you see this message and you are not debugging the ** [ 0.267018] ** kernel, report this immediately to your vendor! ** [ 0.270021] ** ** [ 0.272019] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.274031] ************************************************************* [ 0.277147] NET: Registered protocol family 16 [ 0.278583] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.280054] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.283068] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.286472] cpuidle: using governor menu [ 0.288935] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.291729] PCI: Using configuration type 1 for base access [ 0.293152] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.302078] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.304031] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.308105] cryptd: max_cpu_qlen set to 1000 [ 0.312106] ACPI: Added _OSI(Module Device) [ 0.313016] ACPI: Added _OSI(Processor Device) [ 0.315023] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.317016] ACPI: Added _OSI(Processor Aggregator Device) [ 0.321000] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.328376] ACPI: Interpreter enabled [ 0.330069] ACPI: PM: (supports S0 S3 S4 S5) [ 0.332020] ACPI: Using IOAPIC for interrupt routing [ 0.333128] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.335481] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.345799] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.348045] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.350019] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.353077] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.358358] acpiphp: Slot [2] registered [ 0.359107] acpiphp: Slot [5] registered [ 0.361149] acpiphp: Slot [6] registered [ 0.362124] acpiphp: Slot [3] registered [ 0.363133] acpiphp: Slot [4] registered [ 0.365162] acpiphp: Slot [7] registered [ 0.367140] acpiphp: Slot [8] registered [ 0.368151] acpiphp: Slot [9] registered [ 0.370145] acpiphp: Slot [10] registered [ 0.372149] acpiphp: Slot [11] registered [ 0.373181] acpiphp: Slot [12] registered [ 0.375149] acpiphp: Slot [13] registered [ 0.376148] acpiphp: Slot [14] registered [ 0.378131] acpiphp: Slot [15] registered [ 0.379156] acpiphp: Slot [16] registered [ 0.381149] acpiphp: Slot [17] registered [ 0.382140] acpiphp: Slot [18] registered [ 0.384175] acpiphp: Slot [19] registered [ 0.385130] acpiphp: Slot [20] registered [ 0.387181] acpiphp: Slot [21] registered [ 0.388119] acpiphp: Slot [22] registered [ 0.389129] acpiphp: Slot [23] registered [ 0.391157] acpiphp: Slot [24] registered [ 0.392193] acpiphp: Slot [25] registered [ 0.394136] acpiphp: Slot [26] registered [ 0.396095] acpiphp: Slot [27] registered [ 0.397111] acpiphp: Slot [28] registered [ 0.398089] acpiphp: Slot [29] registered [ 0.399117] acpiphp: Slot [30] registered [ 0.401106] acpiphp: Slot [31] registered [ 0.403073] PCI host bridge to bus 0000:00 [ 0.404021] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.406025] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.408026] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.411027] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.413026] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.416029] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.418178] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.421037] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.423082] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.430016] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.434059] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.436018] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.438020] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.440021] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.442770] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.446172] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.449063] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.451858] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.455798] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.464020] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.468031] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.473117] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.478016] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.483024] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.498019] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.507577] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.514021] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.518021] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.529024] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.537230] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.540497] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.542264] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.543300] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.545153] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.550150] iommu: Default domain type: Passthrough [ 0.552744] SCSI subsystem initialized [ 0.554206] ACPI: bus type USB registered [ 0.555140] usbcore: registered new interface driver usbfs [ 0.557122] usbcore: registered new interface driver hub [ 0.559150] usbcore: registered new device driver usb [ 0.561226] pps_core: LinuxPPS API ver. 1 registered [ 0.563017] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.566105] PTP clock support registered [ 0.569055] EDAC MC: Ver: 3.0.0 [ 0.571167] PCI: Using ACPI for IRQ routing [ 0.573698] NetLabel: Initializing [ 0.575019] NetLabel: domain hash size = 128 [ 0.576012] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.578119] NetLabel: unlabeled traffic allowed by default [ 0.580162] vgaarb: loaded [ 0.581388] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.584024] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.590019] clocksource: Switched to clocksource kvm-clock [ 0.700500] VFS: Disk quotas dquot_6.6.0 [ 0.702086] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.704461] *** VALIDATE ramfs *** [ 0.705658] *** VALIDATE hugetlbfs *** [ 0.707301] pnp: PnP ACPI init [ 0.710489] pnp: PnP ACPI: found 6 devices [ 0.726188] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.729333] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.731482] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.733576] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.735905] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.738134] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.740958] NET: Registered protocol family 2 [ 0.743512] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.748376] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.751868] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.757905] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.761776] TCP: Hash tables configured (established 65536 bind 65536) [ 0.764873] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.767576] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.771482] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.773768] NET: Registered protocol family 1 [ 0.775940] RPC: Registered named UNIX socket transport module. [ 0.778047] RPC: Registered udp transport module. [ 0.779180] RPC: Registered tcp transport module. [ 0.780287] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.781748] NET: Registered protocol family 44 [ 0.783579] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.785723] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.787719] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.789869] PCI: CLS 0 bytes, default 64 [ 0.791722] Unpacking initramfs... [ 2.225229] debug: unmapping init [mem 0xffff98e57cc64000-0xffff98e57ffcffff] [ 2.231690] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.234183] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.238510] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.729538] Initialise system trusted keyrings [ 2.731289] Key type blacklist registered [ 2.733102] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.741971] zbud: loaded [ 2.744863] *** VALIDATE nfs *** [ 2.745992] *** VALIDATE nfs4 *** [ 2.747423] pstore: using deflate compression [ 2.750151] Platform Keyring initialized [ 2.856571] NET: Registered protocol family 38 [ 2.857866] Key type asymmetric registered [ 2.859284] Asymmetric key parser 'x509' registered [ 2.860871] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.864193] io scheduler mq-deadline registered [ 2.865876] io scheduler kyber registered [ 2.867441] io scheduler bfq registered [ 2.869610] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.872570] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.875404] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.878132] ACPI: Power Button [PWRF] [ 2.882620] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.889706] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.901368] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.929907] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.958967] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.963676] Non-volatile memory driver v1.3 [ 2.965326] Linux agpgart interface v0.103 [ 2.997908] virtio_blk virtio1: [vda] 149952 512-byte logical blocks (76.8 MB/73.2 MiB) [ 3.000749] vda: detected capacity change from 0 to 76775424 [ 3.016556] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.019117] vdb: detected capacity change from 0 to 1073741824 [ 3.025892] libphy: Fixed MDIO Bus: probed [ 3.040453] usbcore: registered new interface driver usbserial_generic [ 3.042996] usbserial: USB Serial support registered for generic [ 3.045754] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.049811] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.051529] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.054206] mousedev: PS/2 mouse device common for all mice [ 3.056969] rtc_cmos 00:05: RTC can wake from S4 [ 3.059390] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.063443] rtc_cmos 00:05: registered as rtc0 [ 3.065254] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.068598] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.069822] intel_pstate: CPU model not supported [ 3.075557] hid: raw HID events driver (C) Jiri Kosina [ 3.076027] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.077494] usbcore: registered new interface driver usbhid [ 3.081272] usbhid: USB HID core driver [ 3.082362] drop_monitor: Initializing network drop monitor service [ 3.084685] Initializing XFRM netlink socket [ 3.087072] NET: Registered protocol family 10 [ 3.089823] Segment Routing with IPv6 [ 3.091105] NET: Registered protocol family 17 [ 3.093931] mpls_gso: MPLS GSO support [ 3.099540] RAS: Correctable Errors collector initialized. [ 3.101580] AVX version of gcm_enc/dec engaged. [ 3.103256] AES CTR mode by8 optimization enabled [ 3.178915] sched_clock: Marking stable (3178874596, 0)->(4045274067, -866399471) [ 3.182218] registered taskstats version 1 [ 3.183866] Loading compiled-in X.509 certificates [ 3.185561] zswap: loaded using pool lzo/zbud [ 3.216101] Key type big_key registered [ 3.228758] Key type encrypted registered [ 3.230281] ima: No TPM chip found, activating TPM-bypass! [ 3.232060] ima: Allocated hash algorithm: sha1 [ 3.233697] ima: No architecture policies found [ 3.234811] evm: Initialising EVM extended attributes: [ 3.235937] evm: security.selinux [ 3.236711] evm: security.ima [ 3.237447] evm: security.capability [ 3.238181] evm: HMAC attrs: 0x1 [ 3.239693] rtc_cmos 00:05: setting system clock to 2026-09-17 19:30:14 UTC (1789673414) [ 3.245411] debug: unmapping init [mem 0xffffffffb8603000-0xffffffffb87fffff] [ 3.247489] debug: unmapping init [mem 0xffffffffb7382000-0xffffffffb7658fff] [ 3.255127] Write protecting the kernel read-only data: 28672k [ 3.258302] debug: unmapping init [mem 0xffffffffb5a03000-0xffffffffb5bfffff] [ 3.260136] debug: unmapping init [mem 0xffffffffb6314000-0xffffffffb63fffff] [ 3.288161] 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.293306] systemd[1]: Detected virtualization kvm. [ 3.295342] systemd[1]: Detected architecture x86-64. [ 3.297164] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.322049] systemd[1]: No hostname configured. [ 3.323307] systemd[1]: Set hostname to . [ 3.325438] random: systemd: uninitialized urandom read (16 bytes read) [ 3.327786] systemd[1]: Initializing machine ID from random generator. [ 3.358118] random: ln: uninitialized urandom read (6 bytes read) [ 3.446919] random: systemd: uninitialized urandom read (16 bytes read) [ 3.449430] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.454132] systemd[1]: Reached target Paths. [ OK ] Reached target Paths. [ 3.456950] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Local File Systems. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Timers. [ OK ] Reached target Swap. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket. Starting Journal Service... Starting Create Volatile Files and Directories... [ OK ] Started Memstrack Anylazing Service. Starting Setup Virtual Console... [ OK ] Reached target Sockets. Starting Create list of required st…ce nodes for the current kernel... Starting Apply Kernel Variables... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. Starting Create Static Device Nodes in /dev... [ OK ] Started Setup Virtual Console. Starting dracut cmdline hook... [ OK ] Started Apply Kernel Variables. [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.993001] device-mapper: uevent: version 1.0.3 [ 3.995582] 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... [ 4.280248] random: fast init done [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting dracut initqueue hook..[ 4.631225] virtio_net virtio0 ens2: renamed from eth0 . [ 4.749733] scsi host0: ata_piix [ 4.792200] scsi host1: ata_piix [ 4.794305] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.798026] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.338382] dracut-initqueue[586]: RTNETLINK answers: File exists [ 9.744483] random: crng init done [ 9.746624] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 9.993321] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped target Sockets. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.097557] printk: systemd: 25 output lines suppressed due to ratelimiting [ 11.313297] SELinux: Disabled at runtime. [ 11.370842] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.377449] systemd[1]: Detected virtualization kvm. [ 11.379047] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.819839] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.822885] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.827189] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.830838] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.834141] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.844164] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.856245] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ OK ] Reached target rpc_pipefs.target. Mounting Huge Pages File System... [ OK ] Listening on udev Kernel Socket. Mounting Kernel Debug File System... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on RPCbind Server Activation Socket. Starting Apply Kernel Variables... [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target RPC Port Mapper. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. Starting Remount Root and Kernel File Systems... [ OK ] Created slice User and Session Slice. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on Process Core Dump Socket. Activating swap /dev/disk/by-label/SWAP... [ OK ] Reached target Slices. [ OK ] Created slice system-getty.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [[ 11.990838] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS  OK ] Listening on udev Control Socket. Starting udev Coldplug all Devices... [ OK ] Started Journal Service. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug 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 ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Reached target Swap. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started udev Coldplug all Devices. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... [ 12.303323] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /mnt. [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.639777] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.682521] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.734315] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.757085] EDAC sbridge: Ver: 1.1.2 [ 13.663687] Key type dns_resolver registered [ 13.998806] NFS: Registering the id_resolver key type [ 14.000213] Key type id_resolver registered [ 14.001302] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting 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 daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... [ OK ] Started OpenSSH server daemon. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting Notify NFS peers of a restart... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg149-client login: [ 46.586391] libcfs: loading out-of-tree module taints kernel. [ 46.688279] Key type ._llcrypt registered [ 46.691620] Key type .llcrypt registered [ 46.939838] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 46.947073] alg: No test for adler32 (adler32-zlib) [ 47.983834] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 48.348307] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 50.089277] Key type lgssc registered [ 51.980618] Lustre: Echo OBD driver; http://www.lustre.org/ [ 237.479348] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 242.989664] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 259.712789] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing check_logdir /tmp/testlogs/ [ 263.139138] Lustre: lustre-OST0000-osc-ffff98e5c5ab0800: disconnect after 23s idle [ 267.906942] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing yml_node [ 273.623370] Lustre: DEBUG MARKER: Client: 2.17.58.39 [ 277.099468] Lustre: DEBUG MARKER: MDS: 2.17.58.39 [ 279.925289] Lustre: DEBUG MARKER: OSS: 2.17.58.39 [ 282.217199] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Sep 17 15:34:51 EDT 2026 [ 302.349318] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 304.166868] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 308.008941] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 318.317173] Lustre: Unmounted lustre-client [ 438.145789] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 444.045347] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 469.446485] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 509.533091] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 15:38:39 (1789673919) [ 512.579132] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 514.219695] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 15:38:44 (1789673924) [ 545.961529] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 551.968515] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 575.069960] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 575.832716] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 580.268167] Lustre: Unmounted lustre-client [ 607.558888] Key type lgssc unregistered [ 607.860173] LNet: 15057:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 607.869253] LNetError: 15057:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 607.905952] LNet: Removed LNI 192.168.201.49@tcp [ 608.811441] Key type .llcrypt unregistered [ 608.814513] Key type ._llcrypt unregistered [ 608.953030] hrtimer: interrupt took 20019666 ns [ 624.253992] Key type ._llcrypt registered [ 624.261444] Key type .llcrypt registered [ 625.352791] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 15:40:35 (1789674035) [ 627.033289] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 627.141703] alg: No test for adler32 (adler32-zlib) [ 628.139848] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 628.366779] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 629.999679] Key type lgssc registered [ 631.289642] Lustre: Echo OBD driver; http://www.lustre.org/ [ 709.473453] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 797.200912] Lustre: Unmounted lustre-client [ 824.914677] Key type lgssc unregistered [ 825.137659] LNet: 18910:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 825.145974] LNetError: 18910:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 825.162436] LNet: Removed LNI 192.168.201.49@tcp [ 825.995412] Key type .llcrypt unregistered [ 825.998457] Key type ._llcrypt unregistered [ 836.763114] Key type ._llcrypt registered [ 836.765818] Key type .llcrypt registered [ 838.292433] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 15:44:07 (1789674247) [ 840.632786] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 840.641408] alg: No test for adler32 (adler32-zlib) [ 841.688479] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 841.874886] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 843.528501] Key type lgssc registered [ 845.180499] Lustre: Echo OBD driver; http://www.lustre.org/ [ 900.769884] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 908.288413] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 934.138109] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 936.006873] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 949.152871] Lustre: Unmounted lustre-client [ 980.740366] Key type lgssc unregistered [ 981.104173] LNet: 22515:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 981.115039] LNetError: 22515:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 981.151488] LNet: Removed LNI 192.168.201.49@tcp [ 982.003262] Key type .llcrypt unregistered [ 982.014968] Key type ._llcrypt unregistered [ 992.919694] Key type ._llcrypt registered [ 992.921145] Key type .llcrypt registered [ 994.434458] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 15:46:43 (1789674403) [ 996.879949] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 996.947539] alg: No test for adler32 (adler32-zlib) [ 998.062521] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 998.380232] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 1000.039537] Key type lgssc registered [ 1001.401469] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1054.050853] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1061.275984] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1083.669479] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1086.495893] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 1092.483909] Lustre: Unmounted lustre-client [ 1122.809741] Key type lgssc unregistered [ 1123.152870] LNet: 25701:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1123.159697] LNetError: 25701:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1123.178425] LNet: Removed LNI 192.168.201.49@tcp [ 1124.268114] Key type .llcrypt unregistered [ 1124.271939] Key type ._llcrypt unregistered [ 1139.997663] Key type ._llcrypt registered [ 1140.000349] Key type .llcrypt registered [ 1141.461522] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 15:49:11 (1789674551) [ 1144.101523] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1144.161836] alg: No test for adler32 (adler32-zlib) [ 1145.289268] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 1145.620716] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 1147.351978] Key type lgssc registered [ 1148.720483] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1197.078671] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1202.441480] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1222.629069] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1225.451688] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 1230.827293] Lustre: lustre-MDT0000-mdc-ffff98e5c4e1b800: Connection to lustre-MDT0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1235.967378] Lustre: lustre-MDT0001-mdc-ffff98e5c4e1b800: Connection to lustre-MDT0001 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1243.077344] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1252.319137] Lustre: 26656:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789674647/real 1789674647] req@00000000e3488cd1 x1876609787237888/t0(0) o400->MGC192.168.201.149@tcp@192.168.201.149@tcp:26/25 lens 224/224 e 0 to 1 dl 1789674663 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1252.328586] LustreError: MGC192.168.201.149@tcp: Connection to MGS (at 192.168.201.149@tcp) was lost; in progress operations using this service will fail [ 1253.400163] Lustre: Unmounted lustre-client [ 1272.576744] Key type lgssc unregistered [ 1272.901176] LNet: 29347:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1272.918238] LNetError: 29347:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1272.949921] LNet: Removed LNI 192.168.201.49@tcp [ 1273.665611] Key type .llcrypt unregistered [ 1273.670978] Key type ._llcrypt unregistered [ 1290.198683] Key type ._llcrypt registered [ 1290.201700] Key type .llcrypt registered [ 1292.171608] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 15:51:41 (1789674701) [ 1294.461353] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1294.615729] alg: No test for adler32 (adler32-zlib) [ 1295.707798] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 1295.948430] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 1297.687271] Key type lgssc registered [ 1298.896758] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1347.172935] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1352.733268] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1375.743107] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1377.282912] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 1382.390297] Lustre: lustre-OST0000-osc-ffff98e5c7bb8800: Connection to lustre-OST0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1389.284462] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1399.663666] Lustre: Unmounted lustre-client [ 1436.750946] Key type lgssc unregistered [ 1437.106191] LNet: 32954:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1437.112763] LNetError: 32954:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1438.182755] LNet: Removed LNI 192.168.201.49@tcp [ 1439.353158] Key type .llcrypt unregistered [ 1439.358137] Key type ._llcrypt unregistered [ 1456.302605] Key type ._llcrypt registered [ 1456.312171] Key type .llcrypt registered [ 1457.927244] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 15:54:27 (1789674867) [ 1460.472443] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1460.538457] alg: No test for adler32 (adler32-zlib) [ 1461.690862] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 1462.001479] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 1463.713432] Key type lgssc registered [ 1465.235693] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1521.405531] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1528.307168] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1556.743451] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1559.638949] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 1563.640333] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1568.398297] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1580.100958] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-1715h56m29s [ 1582.510594] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1585.129451] Lustre: lustre-MDT0000-mdc-ffff98e5c465b000: Connection to lustre-MDT0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1593.546389] LustreError: 36735:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff98e5c465b000: can't stat MDS #0: rc = -19 [ 1594.965406] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1603.557901] LustreError: MGC192.168.201.149@tcp: Connection to MGS (at 192.168.201.149@tcp) was lost; in progress operations using this service will fail [ 1603.591962] Lustre: Evicted from MGS (at 192.168.201.149@tcp) after server handle changed from 0x7ff88841816c588f to 0x7ff88841816c5a4f [ 1603.627202] Lustre: MGC192.168.201.149@tcp: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 1608.688979] LustreError: lustre-MDT0000-mdc-ffff98e5c465b000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1608.724590] Lustre: lustre-MDT0000-mdc-ffff98e5c465b000: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 1612.672356] Lustre: DEBUG MARKER: Wait for df (36735) ... [ 1614.415278] Lustre: DEBUG MARKER: done [ 1617.000161] Lustre: Unmounted lustre-client [ 1647.654459] Key type lgssc unregistered [ 1647.888100] LNet: 37751:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1647.897112] LNetError: 37751:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1648.935116] LNet: Removed LNI 192.168.201.49@tcp [ 1650.197851] Key type .llcrypt unregistered [ 1650.199563] Key type ._llcrypt unregistered [ 1690.600799] Key type ._llcrypt registered [ 1690.602263] Key type .llcrypt registered [ 1692.184402] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 15:58:21 (1789675101) [ 1695.189239] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1695.237393] alg: No test for adler32 (adler32-zlib) [ 1696.435496] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 1696.761990] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 1698.527217] Key type lgssc registered [ 1699.628454] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1757.272820] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1763.940292] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1794.926210] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1798.184228] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 1803.499244] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-1716h00m13s [ 1805.203948] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1813.544046] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1816.315976] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1836.511894] Lustre: 41892:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789675227/real 1789675227] req@0000000025e6f75f x1876610366053120/t0(0) o101->lustre-MDT0000-mdc-ffff98e5c465e800@192.168.201.149@tcp:12/10 lens 576/1152 e 0 to 1 dl 1789675247 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1836.536730] Lustre: lustre-MDT0000-mdc-ffff98e5c465e800: Connection to lustre-MDT0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1836.558792] Lustre: lustre-MDT0000-mdc-ffff98e5c465e800: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 1858.594368] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1861.746736] Lustre: DEBUG MARKER: done [ 1867.613379] Lustre: Unmounted lustre-client [ 1897.056559] Key type lgssc unregistered [ 1897.311555] LNet: 42793:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1897.317678] LNetError: 42793:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1897.357218] LNet: Removed LNI 192.168.201.49@tcp [ 1898.472112] Key type .llcrypt unregistered [ 1898.480994] Key type ._llcrypt unregistered [ 1938.548885] Key type ._llcrypt registered [ 1938.552724] Key type .llcrypt registered [ 1940.268535] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 16:02:29 (1789675349) [ 1942.101793] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1943.935365] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 16:02:33 (1789675353) [ 1949.717242] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1949.876658] alg: No test for adler32 (adler32-zlib) [ 1951.098800] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 1951.394040] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 1953.097455] Key type lgssc registered [ 1954.377508] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1987.500786] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 16:03:16 (1789675396) [ 2021.990722] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2028.173842] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2050.929164] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2053.770835] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 2057.451190] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2062.424182] Lustre: Unmounted lustre-client [ 2081.548526] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2133.203686] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2140.261753] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2141.083341] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 2146.068463] Lustre: Unmounted lustre-client [ 2216.773824] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2223.584890] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2224.254630] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 2228.342611] Lustre: Unmounted lustre-client [ 2251.075579] Lustre: DEBUG MARKER: files compared the same [ 2273.064728] Key type lgssc unregistered [ 2273.325298] LNet: 50411:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2273.335382] LNetError: 50411:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2273.371164] LNet: Removed LNI 192.168.201.49@tcp [ 2274.231289] Key type .llcrypt unregistered [ 2274.234096] Key type ._llcrypt unregistered [ 2291.859112] Key type ._llcrypt registered [ 2291.864227] Key type .llcrypt registered [ 2293.441596] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 16:08:22 (1789675702) [ 2296.555527] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2296.725113] alg: No test for adler32 (adler32-zlib) [ 2298.063072] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 2298.534496] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 2300.351461] Key type lgssc registered [ 2301.941067] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2356.756239] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2363.422044] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2388.089537] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2389.877869] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 2394.328407] Lustre: Unmounted lustre-client [ 2425.941928] Key type lgssc unregistered [ 2426.278506] LNet: 53992:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2426.285374] LNetError: 53992:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2426.312196] LNet: Removed LNI 192.168.201.49@tcp [ 2427.358420] Key type .llcrypt unregistered [ 2427.360683] Key type ._llcrypt unregistered [ 2445.197360] Key type ._llcrypt registered [ 2445.198879] Key type .llcrypt registered [ 2446.722360] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 16:10:56 (1789675856) [ 2449.529156] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2449.635036] alg: No test for adler32 (adler32-zlib) [ 2450.626932] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 2451.023647] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 2452.807468] Key type lgssc registered [ 2454.332639] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2540.664615] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2583.870561] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2591.194489] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2620.519319] Key type lgssc unregistered [ 2620.751922] LNet: 57480:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2620.757585] LNetError: 57480:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2620.776510] LNet: Removed LNI 192.168.201.49@tcp [ 2621.529734] Key type .llcrypt unregistered [ 2621.533769] Key type ._llcrypt unregistered [ 2638.509388] Key type ._llcrypt registered [ 2638.511384] Key type .llcrypt registered [ 2639.789138] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 16:14:09 (1789676049) [ 2643.402462] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2643.417323] alg: No test for adler32 (adler32-zlib) [ 2644.562272] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 2644.992539] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 2646.695296] Key type lgssc registered [ 2648.050734] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2730.405715] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 2738.865641] Lustre: Unmounted lustre-client [ 2784.761135] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 16:16:34 (1789676194) [ 2923.968510] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2943.528278] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 2951.431513] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2951.441519] LustreError: 63953:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff98e5c66ba800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2951.459971] Lustre: 58463:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.201.149@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2961.834738] Lustre: Unmounted lustre-client [ 3017.801618] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 16:20:27 (1789676427) [ 3030.439294] Key type lgssc unregistered [ 3030.703294] LNet: 65168:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3030.709345] LNetError: 65168:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3030.722310] LNet: Removed LNI 192.168.201.49@tcp [ 3031.609348] Key type .llcrypt unregistered [ 3031.611162] Key type ._llcrypt unregistered [ 3045.526353] Key type ._llcrypt registered [ 3045.538129] Key type .llcrypt registered [ 3045.995523] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3046.003706] alg: No test for adler32 (adler32-zlib) [ 3047.079216] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 3047.309256] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 3049.016063] Key type lgssc registered [ 3050.779768] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3101.769708] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3107.683541] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3131.877745] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3133.767131] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 3141.016110] Lustre: Unmounted lustre-client [ 3170.912414] Key type lgssc unregistered [ 3171.379493] LNet: 68175:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3171.384205] LNetError: 68175:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3171.403519] LNet: Removed LNI 192.168.201.49@tcp [ 3172.579575] Key type .llcrypt unregistered [ 3172.582231] Key type ._llcrypt unregistered [ 3186.109057] Key type ._llcrypt registered [ 3186.111821] Key type .llcrypt registered [ 3186.953238] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3186.977573] alg: No test for adler32 (adler32-zlib) [ 3188.169851] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 3188.490468] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 3190.319288] Key type lgssc registered [ 3191.581789] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3305.914269] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3312.131239] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3335.864318] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3338.669776] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 3341.456275] Lustre: Unmounted lustre-client [ 3378.471617] Key type lgssc unregistered [ 3378.752241] LNet: 71604:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3378.759029] LNetError: 71604:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3379.824519] LNet: Removed LNI 192.168.201.49@tcp [ 3380.436784] Key type .llcrypt unregistered [ 3380.438242] Key type ._llcrypt unregistered [ 3396.774112] Key type ._llcrypt registered [ 3396.777169] Key type .llcrypt registered [ 3398.214494] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 16:26:47 (1789676807) [ 3400.799993] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3400.830136] alg: No test for adler32 (adler32-zlib) [ 3401.967982] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 3402.235084] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 3403.975993] Key type lgssc registered [ 3405.365544] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3462.576628] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3468.373817] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3493.648154] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3496.555432] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 3502.981453] Lustre: Unmounted lustre-client [ 3503.477669] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 3507.143236] Lustre: Unmounted lustre-client [ 3539.936485] Key type lgssc unregistered [ 3540.425198] LNet: 75287:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3540.438847] LNetError: 75287:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3540.477279] LNet: Removed LNI 192.168.201.49@tcp [ 3541.888478] Key type .llcrypt unregistered [ 3541.891310] Key type ._llcrypt unregistered [ 3558.524756] Key type ._llcrypt registered [ 3558.526223] Key type .llcrypt registered [ 3559.032286] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3559.045417] alg: No test for adler32 (adler32-zlib) [ 3560.101137] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 3560.462440] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 3562.239507] Key type lgssc registered [ 3563.053036] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3620.314408] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3626.455950] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3647.278521] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3650.077396] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 3658.453401] Lustre: Unmounted lustre-client [ 3687.226410] Key type lgssc unregistered [ 3687.457798] LNet: 78313:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3687.464074] LNetError: 78313:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3687.478910] LNet: Removed LNI 192.168.201.49@tcp [ 3688.146978] Key type .llcrypt unregistered [ 3688.149154] Key type ._llcrypt unregistered [ 3708.258067] Key type ._llcrypt registered [ 3708.260270] Key type .llcrypt registered [ 3709.968904] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 16:31:59 (1789677119) [ 3712.904311] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3712.920989] alg: No test for adler32 (adler32-zlib) [ 3714.036775] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 3714.263894] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 3715.911269] Key type lgssc registered [ 3717.369430] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3768.878990] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3775.728569] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3797.971834] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3800.564791] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 3805.266268] Lustre: lustre: root_squash is set to 0:0 [ 3810.366603] Lustre: lustre: nosquash_nids is cleared [ 3819.059443] Lustre: lustre: root_squash is set to 500:500 [ 3826.797670] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.201.49@tcp 192.168.0.[2,10]@tcp [ 3836.789214] Lustre: lustre: nosquash_nids set to 192.168.201.49/24@tcp [ 3844.922305] Lustre: Unmounted lustre-client [ 3879.465689] Key type lgssc unregistered [ 3879.975631] LNet: 82288:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3879.994857] LNetError: 82288:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3881.085567] LNet: Removed LNI 192.168.201.49@tcp [ 3882.019820] Key type .llcrypt unregistered [ 3882.028033] Key type ._llcrypt unregistered [ 3903.787507] Key type ._llcrypt registered [ 3903.789823] Key type .llcrypt registered [ 3905.195514] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 16:35:14 (1789677314) [ 3908.354301] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3910.794257] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 16:35:20 (1789677320) [ 3913.569847] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3913.644982] alg: No test for adler32 (adler32-zlib) [ 3915.182508] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 3915.679433] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 3917.415316] Key type lgssc registered [ 3918.882726] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3972.563265] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3979.534531] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4002.548210] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4003.430250] Lustre: lustre: root_squash is set to 500:500 [ 4003.469430] Lustre: lustre: nosquash_nids set to 192.168.201.49/24@tcp [ 4004.599524] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 4010.414604] Lustre: Unmounted lustre-client [ 4040.112041] Key type lgssc unregistered [ 4040.528452] LNet: 86254:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4040.539771] LNetError: 86254:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4040.562697] LNet: Removed LNI 192.168.201.49@tcp [ 4041.399942] Key type .llcrypt unregistered [ 4041.405946] Key type ._llcrypt unregistered [ 4061.024685] Key type ._llcrypt registered [ 4061.026177] Key type .llcrypt registered [ 4063.991290] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4067.481814] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 16:37:55 (1789677475) [ 4093.266109] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4093.305453] alg: No test for adler32 (adler32-zlib) [ 4094.413577] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 4094.770942] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 4096.496192] Key type lgssc registered [ 4098.351686] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4187.332818] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4194.177880] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4221.629945] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4307.276329] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4314.191418] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4338.346642] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4356.072263] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 4394.763238] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff98e5c618b800.ost_server_uuid 50 [ 4396.316773] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff98e5c618b800.ost_server_uuid in IDLE state after 0 sec [ 4396.888162] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 4400.481308] Lustre: Unmounted lustre-client [ 4402.204624] Lustre: Unmounted lustre-client [ 4447.270553] Key type lgssc unregistered [ 4447.553140] LNet: 93923:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4447.558806] LNetError: 93923:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4447.573761] LNet: Removed LNI 192.168.201.49@tcp [ 4448.298577] Key type .llcrypt unregistered [ 4448.300764] Key type ._llcrypt unregistered [ 4480.227466] Key type ._llcrypt registered [ 4480.232034] Key type .llcrypt registered [ 4481.959855] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 16:44:51 (1789677891) [ 4501.696721] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4501.748237] alg: No test for adler32 (adler32-zlib) [ 4502.884527] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 4503.168415] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 4504.937193] Key type lgssc registered [ 4506.364097] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4595.461898] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4601.456765] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4625.967412] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4627.552075] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 4647.903584] Lustre: 95295:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789678043/real 1789678043] req@000000000290ec6d x1876613308355712/t0(0) o400->lustre-OST0000-osc-ffff98e5d2f59800@192.168.201.149@tcp:28/4 lens 224/224 e 0 to 1 dl 1789678059 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4647.936141] Lustre: lustre-OST0000-osc-ffff98e5d2f59800: Connection to lustre-OST0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4653.065212] Lustre: 95295:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789678048/real 1789678048] req@00000000787ad4d6 x1876613308356224/t0(0) o400->lustre-OST0000-osc-ffff98e5d2f59800@192.168.201.149@tcp:28/4 lens 224/224 e 0 to 1 dl 1789678064 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4656.396987] Lustre: lustre-OST0000-osc-ffff98e5d2f59800: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 4659.167450] Lustre: 95295:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789678054/real 1789678054] req@0000000023a8568c x1876613308356736/t0(0) o400->lustre-OST0000-osc-ffff98e5d2f59800@192.168.201.149@tcp:28/4 lens 224/224 e 0 to 1 dl 1789678070 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4663.279717] Lustre: lustre-MDT0000-mdc-ffff98e5d2f59800: Connection to lustre-MDT0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4679.647124] Lustre: 95296:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789678074/real 1789678074] req@00000000d665fe66 x1876613308359296/t0(0) o400->MGC192.168.201.149@tcp@192.168.201.149@tcp:26/25 lens 224/224 e 0 to 1 dl 1789678090 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4679.685336] LustreError: MGC192.168.201.149@tcp: Connection to MGS (at 192.168.201.149@tcp) was lost; in progress operations using this service will fail [ 4688.888233] Lustre: Evicted from MGS (at 192.168.201.149@tcp) after server handle changed from 0xf192dd0f6735febe to 0xf192dd0f67360150 [ 4688.909222] Lustre: MGC192.168.201.149@tcp: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 4694.119043] Lustre: lustre-MDT0000-mdc-ffff98e5d2f59800: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 4699.560627] Lustre: Unmounted lustre-client [ 4736.321556] Key type lgssc unregistered [ 4736.602102] LNet: 99594:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4736.610879] LNetError: 99594:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4736.627392] LNet: Removed LNI 192.168.201.49@tcp [ 4737.348761] Key type .llcrypt unregistered [ 4737.353560] Key type ._llcrypt unregistered [ 4753.337975] Key type ._llcrypt registered [ 4753.343729] Key type .llcrypt registered [ 4754.675729] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 16:49:24 (1789678164) [ 4769.108461] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4769.180759] alg: No test for adler32 (adler32-zlib) [ 4770.263785] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 4770.676777] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 4772.479253] Key type lgssc registered [ 4773.711457] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4819.511081] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4929.517568] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4936.499617] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4959.918105] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4961.553047] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 4963.782469] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4965.628910] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 16:52:55 (1789678375) [ 5212.468871] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5222.797688] Lustre: Unmounted lustre-client [ 5353.834996] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5360.334245] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5385.880402] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5441.516916] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 17:00:50 (1789678850) [ 5548.827402] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5554.033499] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5580.099895] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5580.699229] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 5587.007106] Lustre: Unmounted lustre-client [ 5620.833541] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 17:03:50 (1789679030) [ 5718.981507] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5724.713802] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5746.695274] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5747.421241] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 5751.913519] Lustre: Unmounted lustre-client [ 5780.034345] Key type lgssc unregistered [ 5780.380829] LNet: 122621:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5780.394204] LNetError: 122621:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5780.413251] LNet: Removed LNI 192.168.201.49@tcp [ 5781.269518] Key type .llcrypt unregistered [ 5781.272649] Key type ._llcrypt unregistered [ 5797.203298] Key type ._llcrypt registered [ 5797.205204] Key type .llcrypt registered [ 5798.535298] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 17:06:48 (1789679208) [ 5801.098305] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5801.123519] alg: No test for adler32 (adler32-zlib) [ 5802.160219] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 5802.400448] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 5804.103289] Key type lgssc registered [ 5804.862399] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5872.784397] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5881.655563] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5910.024251] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5912.209693] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 5926.018764] Lustre: Unmounted lustre-client [ 5959.014173] Key type lgssc unregistered [ 5959.421541] LNet: 126217:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5959.429505] LNetError: 126217:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5959.464350] LNet: Removed LNI 192.168.201.49@tcp [ 5960.483863] Key type .llcrypt unregistered [ 5960.488914] Key type ._llcrypt unregistered [ 5980.844783] Key type ._llcrypt registered [ 5980.847792] Key type .llcrypt registered [ 5982.813261] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 17:09:51 (1789679391) [ 5986.315407] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5986.325643] alg: No test for adler32 (adler32-zlib) [ 5987.718435] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 5988.058104] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 5989.711272] Key type lgssc registered [ 5991.414716] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6048.475467] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6055.949717] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6084.692482] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6087.554832] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 6092.777457] Lustre: lustre-OST0000-osc-ffff98e5c8d4f800: Connection to lustre-OST0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6117.074327] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff98e5c8d4f800.ost_server_uuid 50 [ 6119.350968] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6131.097660] Lustre: Unmounted lustre-client [ 6156.235084] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 17:12:45 (1789679565) [ 6196.977186] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6206.915138] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6232.648534] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6257.778113] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6258.568358] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 6263.797860] Lustre: lustre-OST0000-osc-ffff98e5c66bd000: Connection to lustre-OST0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6290.585381] Lustre: Unmounted lustre-client [ 6353.577671] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 17:16:03 (1789679763) [ 6391.350429] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6398.329210] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6420.727907] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6446.327928] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6446.955596] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 6452.230844] Lustre: lustre-OST0000-osc-ffff98e5c696e000: Connection to lustre-OST0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6468.134512] Lustre: Unmounted lustre-client [ 6523.278813] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 17:18:52 (1789679932) [ 6625.755164] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6631.869493] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6659.671658] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6746.573589] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6753.508834] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6780.277940] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6813.016538] LustreError: 127174:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 6813.069343] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 6861.797742] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6864.317614] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6868.030883] Lustre: Unmounted lustre-client [ 6907.228244] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 17:25:16 (1789680316) [ 6948.100488] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6956.530406] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6983.735330] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7022.658302] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7057.393627] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 7104.255752] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7106.666227] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7120.113393] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7130.524297] Lustre: Unmounted lustre-client [ 7190.881594] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 17:30:00 (1789680600) [ 7227.322547] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7234.211722] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7260.073477] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7260.879288] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 7287.657236] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7289.789970] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7306.615481] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff98e5c6563800.ost_server_uuid 50 [ 7308.093307] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff98e5c6563800.ost_server_uuid in IDLE state after 0 sec [ 7311.249879] Lustre: Unmounted lustre-client [ 7311.619289] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7311.636326] Lustre: Skipped 3 previous similar messages [ 7311.782827] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 7313.164125] LustreError: 149660:0:(sec.c:409:import_sec_validate_get()) import 00000000b0ba77b1 (NEW) with no sec [ 7379.701657] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 17:33:09 (1789680789) [ 7418.468382] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7425.681356] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7450.333686] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7478.757905] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7479.299522] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7479.455750] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 7495.233980] Lustre: Unmounted lustre-client [ 7495.244240] Lustre: Skipped 1 previous similar message [ 7533.844136] Key type lgssc unregistered [ 7534.240258] LNet: 153080:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7534.250920] LNetError: 153080:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7534.280609] LNet: Removed LNI 192.168.201.49@tcp [ 7534.945679] Key type .llcrypt unregistered [ 7534.947151] Key type ._llcrypt unregistered [ 7549.119816] Key type ._llcrypt registered [ 7549.121989] Key type .llcrypt registered [ 7550.310391] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 17:36:00 (1789680960) [ 7551.593332] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7551.658293] alg: No test for adler32 (adler32-zlib) [ 7552.866461] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 7553.230704] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 7554.951484] Key type lgssc registered [ 7556.119968] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7607.909744] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7614.164662] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7633.515313] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7652.559505] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7653.077647] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7654.210603] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 7658.805746] LustreError: lustre-MDT0001-mdc-ffff98e5d179b800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7658.829151] Lustre: lustre-MDT0001-mdc-ffff98e5d179b800: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 7664.371679] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7665.861736] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7689.248403] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7693.989100] Lustre: Unmounted lustre-client [ 7726.902306] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 17:38:56 (1789681136) [ 7821.622934] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7826.983868] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7850.437215] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7851.157463] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 7875.120372] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7876.979457] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7881.709916] Lustre: lustre-OST0001-osc-ffff98e5d179c800: Connection to lustre-OST0001 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7895.765348] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7906.092115] Lustre: Unmounted lustre-client [ 7939.418141] Key type lgssc unregistered [ 7939.719803] LNet: 162689:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7939.739889] LNetError: 162689:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7939.769618] LNet: Removed LNI 192.168.201.49@tcp [ 7940.721289] Key type .llcrypt unregistered [ 7940.726809] Key type ._llcrypt unregistered [ 7969.900416] Key type ._llcrypt registered [ 7969.906955] Key type .llcrypt registered [ 7971.434369] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 17:43:00 (1789681380) [ 7973.764432] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7973.841636] alg: No test for adler32 (adler32-zlib) [ 7974.954438] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 7975.200142] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 7976.879528] Key type lgssc registered [ 7978.259412] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8027.061776] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8032.150358] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8051.303775] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8052.937278] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 8097.953126] Lustre: Unmounted lustre-client [ 8134.905281] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8135.515724] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 8171.222807] Lustre: Unmounted lustre-client [ 8196.055459] Key type lgssc unregistered [ 8196.310040] LNet: 167131:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8196.314532] LNetError: 167131:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8196.334524] LNet: Removed LNI 192.168.201.49@tcp [ 8196.940449] Key type .llcrypt unregistered [ 8196.943187] Key type ._llcrypt unregistered [ 8210.800456] Key type ._llcrypt registered [ 8210.801917] Key type .llcrypt registered [ 8212.010847] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 17:47:01 (1789681621) [ 8214.456272] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8214.486268] alg: No test for adler32 (adler32-zlib) [ 8215.537765] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 8215.839531] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 8217.503255] Key type lgssc registered [ 8218.684738] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8260.112631] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8265.131433] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8282.039184] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8288.891587] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 8304.539222] Lustre: Unmounted lustre-client [ 8337.808527] Key type lgssc unregistered [ 8338.080409] LNet: 170878:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8338.084659] LNetError: 170878:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8338.097718] LNet: Removed LNI 192.168.201.49@tcp [ 8338.672674] Key type .llcrypt unregistered [ 8338.674602] Key type ._llcrypt unregistered [ 8350.446888] Key type ._llcrypt registered [ 8350.448359] Key type .llcrypt registered [ 8350.866974] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8350.883604] alg: No test for adler32 (adler32-zlib) [ 8351.943463] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 8352.149735] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 8353.847203] Key type lgssc registered [ 8354.852496] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8398.294265] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8402.839245] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8420.400143] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8425.995471] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 8431.896421] Lustre: Unmounted lustre-client [ 8456.126372] Key type lgssc unregistered [ 8456.355776] LNet: 173932:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8456.368757] LNetError: 173932:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8456.384290] LNet: Removed LNI 192.168.201.49@tcp [ 8456.974169] Key type .llcrypt unregistered [ 8456.975861] Key type ._llcrypt unregistered [ 8469.636700] Key type ._llcrypt registered [ 8469.638529] Key type .llcrypt registered [ 8470.647778] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 17:51:20 (1789681880) [ 8472.994436] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8473.020966] alg: No test for adler32 (adler32-zlib) [ 8474.068180] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 8474.282817] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 8475.959806] Key type lgssc registered [ 8476.946527] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8515.560763] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8520.244643] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8538.361300] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8545.322855] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 8560.444450] Lustre: Unmounted lustre-client [ 8585.030361] Key type lgssc unregistered [ 8585.221058] LNet: 177673:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8585.226287] LNetError: 177673:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8585.241500] LNet: Removed LNI 192.168.201.49@tcp [ 8585.708719] Key type .llcrypt unregistered [ 8585.710974] Key type ._llcrypt unregistered [ 8594.752815] Key type ._llcrypt registered [ 8594.754716] Key type .llcrypt registered [ 8594.936383] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8594.956923] alg: No test for adler32 (adler32-zlib) [ 8595.918964] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 8596.122470] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 8597.783212] Key type lgssc registered [ 8598.685644] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8632.615838] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8636.455332] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8650.997601] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8662.066249] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 8667.975804] Lustre: Unmounted lustre-client [ 8690.014476] Key type lgssc unregistered [ 8690.193045] LNet: 180730:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8690.201426] LNetError: 180730:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8690.218397] LNet: Removed LNI 192.168.201.49@tcp [ 8690.579219] Key type .llcrypt unregistered [ 8690.581494] Key type ._llcrypt unregistered [ 8700.881081] Key type ._llcrypt registered [ 8700.882994] Key type .llcrypt registered [ 8701.664800] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 17:55:12 (1789682112) [ 8714.961977] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8714.973506] alg: No test for adler32 (adler32-zlib) [ 8715.995221] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 8716.202051] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 8717.871248] Key type lgssc registered [ 8718.617485] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8771.210946] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8774.962398] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8791.974588] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8831.016256] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 17:57:21 (1789682241) [ 8853.929507] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8857.973661] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8873.672552] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8884.750059] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 8888.038166] Lustre: Unmounted lustre-client [ 8919.562246] Key type lgssc unregistered [ 8919.747457] LNet: 187814:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8919.758072] LNetError: 187814:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8919.769097] LNet: Removed LNI 192.168.201.49@tcp [ 8920.284485] Key type .llcrypt unregistered [ 8920.285593] Key type ._llcrypt unregistered [ 8929.850849] Key type ._llcrypt registered [ 8929.852106] Key type .llcrypt registered [ 8930.506236] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8931.849595] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 17:59:02 (1789682342) [ 8944.242543] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8944.296637] alg: No test for adler32 (adler32-zlib) [ 8945.295215] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 8945.473826] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 8947.103260] Key type lgssc registered [ 8947.996659] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9004.025236] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9007.375228] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9022.758995] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9035.182594] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9036.530384] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 9049.730220] Lustre: Unmounted lustre-client [ 9139.520600] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9142.636819] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9155.926212] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9181.812027] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 18:03:12 (1789682592) [ 9182.475439] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9183.152921] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 18:03:13 (1789682593) [ 9239.779270] Key type lgssc unregistered [ 9239.953663] LNet: 199224:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9239.957343] LNetError: 199224:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9239.973861] LNet: Removed LNI 192.168.201.49@tcp [ 9240.378723] Key type .llcrypt unregistered [ 9240.382842] Key type ._llcrypt unregistered [ 9248.892816] Key type ._llcrypt registered [ 9248.895808] Key type .llcrypt registered [ 9249.571603] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 18:04:20 (1789682660) [ 9276.868968] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9276.877657] alg: No test for adler32 (adler32-zlib) [ 9277.763704] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 9277.881608] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 9279.496414] Key type lgssc registered [ 9280.065414] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9300.682427] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9303.961261] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9327.529468] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9347.254505] Key type lgssc unregistered [ 9347.386658] LNet: 202942:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9347.390572] LNetError: 202942:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9347.405136] LNet: Removed LNI 192.168.201.49@tcp [ 9347.800975] Key type .llcrypt unregistered [ 9347.802087] Key type ._llcrypt unregistered [ 9355.037483] Key type ._llcrypt registered [ 9355.039888] Key type .llcrypt registered [ 9355.625672] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 18:06:06 (1789682766) [ 9356.774603] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9356.786167] alg: No test for adler32 (adler32-zlib) [ 9357.669834] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 9357.785344] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 9359.383378] Key type lgssc registered [ 9359.891025] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9383.165450] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9385.478886] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9396.200650] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9402.858485] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 9407.975976] Lustre: lustre-MDT0000-mdc-ffff98e5c753c800: Connection to lustre-MDT0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9413.093965] Lustre: lustre-MDT0001-mdc-ffff98e5c753c800: Connection to lustre-MDT0001 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9428.451131] LustreError: MGC192.168.201.149@tcp: Connection to MGS (at 192.168.201.149@tcp) was lost; in progress operations using this service will fail [ 9428.463544] Lustre: Evicted from MGS (at 192.168.201.149@tcp) after server handle changed from 0x66f54123ed607baa to 0x66f54123ed609511 [ 9428.470349] Lustre: MGC192.168.201.149@tcp: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 9434.083699] Lustre: 206042:0:(mgc_request.c:1900:mgc_process_log()) MGC192.168.201.149@tcp: IR log lustre-cliir failed, not fatal: rc = -2 [ 9446.662098] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9448.932946] LustreError: lustre-MDT0000-mdc-ffff98e5c753c800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9448.955323] Lustre: lustre-MDT0000-mdc-ffff98e5c753c800: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 9450.460171] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 3 sec [ 9452.826799] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9454.543169] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 1 sec [ 9455.411113] Lustre: Unmounted lustre-client [ 9474.980745] Key type lgssc unregistered [ 9475.129807] LNet: 207892:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9475.132932] LNetError: 207892:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9475.143836] LNet: Removed LNI 192.168.201.49@tcp [ 9475.473523] Key type .llcrypt unregistered [ 9475.475447] Key type ._llcrypt unregistered [ 9482.190221] Key type ._llcrypt registered [ 9482.192056] Key type .llcrypt registered [ 9482.817924] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 18:08:13 (1789682893) [ 9483.963486] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9483.973701] alg: No test for adler32 (adler32-zlib) [ 9484.889654] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 9485.026504] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 9486.631227] Key type lgssc registered [ 9487.162281] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9511.661765] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9514.065956] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9549.806689] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9552.792147] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9573.257693] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9583.086252] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9610.128952] Key type lgssc unregistered [ 9610.261337] LNet: 213164:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9610.264426] LNetError: 213164:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9610.273359] LNet: Removed LNI 192.168.201.49@tcp [ 9610.519303] Key type .llcrypt unregistered [ 9610.523368] Key type ._llcrypt unregistered [ 9635.232461] Key type ._llcrypt registered [ 9635.234162] Key type .llcrypt registered [ 9635.794404] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 18:10:46 (1789683046) [ 9657.236934] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9657.290521] alg: No test for adler32 (adler32-zlib) [ 9658.433224] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [ 9658.674966] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [ 9660.351928] Key type lgssc registered [ 9661.732407] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9744.687396] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9749.749228] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9770.471141] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9813.710386] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 18:13:43 (1789683223) [ 9819.038479] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 18:13:49 (1789683229) [ 9865.037336] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9875.175252] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9907.052376] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9909.974594] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [ 9919.595770] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9922.687143] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9925.173948] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9927.268391] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9930.726335] Lustre: lustre-MDT0000-mdc-ffff98e5c6bdc800: Connection to lustre-MDT0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9946.080077] Lustre: 215051:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789683341/real 1789683341] req@000000007ebed5a4 x1876618713769984/t0(0) o400->MGC192.168.201.149@tcp@192.168.201.149@tcp:26/25 lens 224/224 e 0 to 1 dl 1789683357 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9946.137521] LustreError: MGC192.168.201.149@tcp: Connection to MGS (at 192.168.201.149@tcp) was lost; in progress operations using this service will fail [ 9956.352276] Lustre: Evicted from MGS (at 192.168.201.149@tcp) after server handle changed from 0x70092b1b5b2431a5 to 0x70092b1b5b24331f [ 9956.369581] Lustre: MGC192.168.201.149@tcp: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 9965.244199] Lustre: lustre-MDT0000-mdc-ffff98e5c6bdc800: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [ 9976.193954] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9978.216712] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9982.194856] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9987.044679] Lustre: lustre-MDT0000-mdc-ffff98e5c6bdc800: Connection to lustre-MDT0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [10003.432218] Lustre: 215051:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789683398/real 1789683398] req@000000006ee6f67b x1876618713779456/t0(0) o400->MGC192.168.201.149@tcp@192.168.201.149@tcp:26/25 lens 224/224 e 0 to 1 dl 1789683414 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10003.473791] LustreError: MGC192.168.201.149@tcp: Connection to MGS (at 192.168.201.149@tcp) was lost; in progress operations using this service will fail [10012.297841] Lustre: lustre-MDT0000-mdc-ffff98e5c6bdc800: Connection restored to 192.168.201.149@tcp (at 192.168.201.149@tcp) [10013.367057] Lustre: Evicted from MGS (at 192.168.201.149@tcp) after server handle changed from 0x70092b1b5b24331f to 0x70092b1b5b24382e [10025.460710] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10027.737566] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10032.724948] Lustre: Unmounted lustre-client [10112.248695] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10119.821938] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10144.146147] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10155.039506] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [10157.780613] Lustre: Unmounted lustre-client [10188.638392] Key type lgssc unregistered [10189.055068] LNet: 225631:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10189.065463] LNetError: 225631:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10189.097413] LNet: Removed LNI 192.168.201.49@tcp [10190.071061] Key type .llcrypt unregistered [10190.072620] Key type ._llcrypt unregistered [10209.553179] Key type ._llcrypt registered [10209.559672] Key type .llcrypt registered [10211.326402] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 18:20:20 (1789683620) [10216.438657] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10216.552410] alg: No test for adler32 (adler32-zlib) [10217.875089] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [10218.334801] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [10220.103496] Key type lgssc registered [10221.794357] Lustre: Echo OBD driver; http://www.lustre.org/ [10285.623804] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10292.685440] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10317.924122] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10325.228228] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [10333.342591] Lustre: Unmounted lustre-client [10414.241973] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10422.471906] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10453.771090] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10459.751338] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [10470.834939] Lustre: Unmounted lustre-client [10552.185321] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10561.984601] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10591.739378] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10592.864770] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [10595.735447] Lustre: Unmounted lustre-client [10627.674499] Key type lgssc unregistered [10628.019358] LNet: 232686:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10628.041935] LNetError: 232686:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10628.086675] LNet: Removed LNI 192.168.201.49@tcp [10629.480865] Key type .llcrypt unregistered [10629.484391] Key type ._llcrypt unregistered [10655.545723] Key type ._llcrypt registered [10655.547296] Key type .llcrypt registered [10657.997371] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 18:27:46 (1789684066) [10663.517451] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10663.546665] alg: No test for adler32 (adler32-zlib) [10665.250746] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [10665.862949] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [10667.679627] Key type lgssc registered [10669.626195] Lustre: Echo OBD driver; http://www.lustre.org/ [10721.894919] Key type lgssc unregistered [10722.168392] LNet: 235007:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10722.176397] LNetError: 235007:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10722.201868] LNet: Removed LNI 192.168.201.49@tcp [10723.425215] Key type .llcrypt unregistered [10723.428766] Key type ._llcrypt unregistered [10755.161064] Key type ._llcrypt registered [10755.167131] Key type .llcrypt registered [10755.748435] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10755.778948] alg: No test for adler32 (adler32-zlib) [10756.978765] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [10757.207750] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [10758.952298] Key type lgssc registered [10760.599818] Lustre: Echo OBD driver; http://www.lustre.org/ [10852.723428] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10860.819422] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10887.718666] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10949.596818] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10952.097341] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 18:32:41 (1789684361) [10991.173617] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10998.290267] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11021.316431] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11046.211971] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11048.170089] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [11053.547887] Lustre: lustre-OST0001-osc-ffff98e5d1500000: Connection to lustre-OST0001 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [11061.202822] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11071.605987] Lustre: Unmounted lustre-client [11116.352509] Key type lgssc unregistered [11116.681376] LNet: 242123:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11116.688050] LNetError: 242123:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11116.720857] LNet: Removed LNI 192.168.201.49@tcp [11117.860982] Key type .llcrypt unregistered [11117.871581] Key type ._llcrypt unregistered [11153.951940] Key type ._llcrypt registered [11153.961694] Key type .llcrypt registered [11155.808409] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 18:36:05 (1789684565) [11168.810513] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11168.992917] alg: No test for adler32 (adler32-zlib) [11170.272910] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [11170.677663] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [11172.480879] Key type lgssc registered [11174.454520] Lustre: Echo OBD driver; http://www.lustre.org/ [11224.377562] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11230.405174] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11250.240511] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 18:37:40 (1789684660) [11284.314633] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11291.378719] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11313.327936] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11315.106300] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [11323.328523] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11331.900334] Lustre: Unmounted lustre-client [11422.359923] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11427.404125] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11480.105427] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11480.758704] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [11483.167593] Lustre: Unmounted lustre-client [11508.738568] Key type lgssc unregistered [11509.053553] LNet: 249837:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11509.062776] LNetError: 249837:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11509.089579] LNet: Removed LNI 192.168.201.49@tcp [11509.674909] Key type .llcrypt unregistered [11509.680971] Key type ._llcrypt unregistered [11530.982940] Key type ._llcrypt registered [11530.993478] Key type .llcrypt registered [11531.399285] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11531.412210] alg: No test for adler32 (adler32-zlib) [11532.382189] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [11532.557157] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [11534.207228] Key type lgssc registered [11535.052300] Lustre: Echo OBD driver; http://www.lustre.org/ [11598.136550] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11603.091549] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11620.569503] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11664.934121] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11666.488918] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 18:44:36 (1789685076) [11693.508876] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11698.591958] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11716.734511] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11720.656389] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [11723.801204] Lustre: Unmounted lustre-client [11752.545382] Key type lgssc unregistered [11752.772942] LNet: 256459:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11752.783669] LNetError: 256459:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11752.796386] LNet: Removed LNI 192.168.201.49@tcp [11753.477698] Key type .llcrypt unregistered [11753.479782] Key type ._llcrypt unregistered [11768.069611] Key type ._llcrypt registered [11768.075265] Key type .llcrypt registered [11769.295854] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11770.813525] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 18:46:20 (1789685180) [11778.885890] Key type .llcrypt unregistered [11778.889931] Key type ._llcrypt unregistered [11787.707769] Key type ._llcrypt registered [11787.713961] Key type .llcrypt registered [11787.957517] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11788.001464] alg: No test for adler32 (adler32-zlib) [11789.018165] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [11789.279185] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [11790.937798] Key type lgssc registered [11792.072479] Lustre: Echo OBD driver; http://www.lustre.org/ [11852.542117] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11874.132632] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [11878.266281] Lustre: Unmounted lustre-client [11909.082505] Key type lgssc unregistered [11909.329636] LNet: 259908:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11909.333092] LNetError: 259908:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11909.346720] LNet: Removed LNI 192.168.201.49@tcp [11910.238549] Key type .llcrypt unregistered [11910.241245] Key type ._llcrypt unregistered [11927.958973] Key type ._llcrypt registered [11927.960781] Key type .llcrypt registered [11929.496682] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 18:48:58 (1789685338) [11932.612419] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11932.720191] alg: No test for adler32 (adler32-zlib) [11934.056435] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [11934.416553] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [11936.183232] Key type lgssc registered [11938.031394] Lustre: Echo OBD driver; http://www.lustre.org/ [12021.017688] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12053.002504] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12060.134982] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12062.948648] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [12066.641110] Lustre: Unmounted lustre-client [12103.462844] Key type lgssc unregistered [12103.649348] LNet: 263444:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12103.654140] LNetError: 263444:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12103.668341] LNet: Removed LNI 192.168.201.49@tcp [12104.254472] Key type .llcrypt unregistered [12104.255758] Key type ._llcrypt unregistered [12120.858128] Key type ._llcrypt registered [12120.859374] Key type .llcrypt registered [12122.390282] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 18:52:11 (1789685531) [12124.993549] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12125.087518] alg: No test for adler32 (adler32-zlib) [12126.206834] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [12126.447372] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [12128.143306] Key type lgssc registered [12129.542580] Lustre: Echo OBD driver; http://www.lustre.org/ [12178.934274] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12184.395263] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12213.970132] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12217.176811] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [12222.445459] Lustre: lustre-MDT0000-mdc-ffff98e5c5d99000: Connection to lustre-MDT0000 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [12224.821922] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12224.879684] LustreError: 266597:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12225.360665] LustreError: MGC192.168.201.149@tcp: Connection to MGS (at 192.168.201.149@tcp) was lost; in progress operations using this service will fail [12225.459302] Lustre: Unmounted lustre-client [12247.562815] Key type lgssc unregistered [12248.052196] LNet: 267009:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12248.076698] LNetError: 267009:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12248.127528] LNet: Removed LNI 192.168.201.49@tcp [12249.007155] Key type .llcrypt unregistered [12249.008432] Key type ._llcrypt unregistered [12266.708706] Key type ._llcrypt registered [12266.711199] Key type .llcrypt registered [12268.040887] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 18:54:37 (1789685677) [12271.135509] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12271.189300] alg: No test for adler32 (adler32-zlib) [12272.329095] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [12272.691422] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [12274.455551] Key type lgssc registered [12275.925412] Lustre: Echo OBD driver; http://www.lustre.org/ [12332.662450] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12342.600665] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12373.531599] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12376.576519] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [12381.729305] Lustre: lustre-MDT0001-mdc-ffff98e5d146f800: Connection to lustre-MDT0001 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [12385.961274] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12390.306225] Lustre: Unmounted lustre-client [12422.135116] Key type lgssc unregistered [12422.404867] LNet: 270589:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12422.416117] LNetError: 270589:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12422.433870] LNet: Removed LNI 192.168.201.49@tcp [12423.303370] Key type .llcrypt unregistered [12423.305451] Key type ._llcrypt unregistered [12445.009222] Key type ._llcrypt registered [12445.016995] Key type .llcrypt registered [12446.899511] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 18:57:36 (1789685856) [12466.867099] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12466.889816] alg: No test for adler32 (adler32-zlib) [12468.092088] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [12468.441714] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [12470.247564] Key type lgssc registered [12471.497377] Lustre: Echo OBD driver; http://www.lustre.org/ [12597.752499] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12600.639638] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [12653.060795] Lustre: lustre-MDT0001-mdc-ffff98e5c5ab2000: Connection to lustre-MDT0001 (at 192.168.201.149@tcp) was lost; in progress operations using this service will wait for recovery to complete [12671.573410] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12681.966695] Lustre: Unmounted lustre-client [12717.330620] Key type lgssc unregistered [12717.866412] LNet: 276392:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12717.883699] LNetError: 276392:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12718.955902] LNet: Removed LNI 192.168.201.49@tcp [12720.555216] Key type .llcrypt unregistered [12720.562847] Key type ._llcrypt unregistered [12749.609619] Key type ._llcrypt registered [12749.612586] Key type .llcrypt registered [12751.101873] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 19:02:40 (1789686160) [12754.184796] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12756.897492] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 19:02:45 (1789686165) [12758.909942] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12762.466429] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 19:02:51 (1789686171) [12764.177692] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12766.985796] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 19:02:55 (1789686175) [12769.129133] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12771.614806] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 19:03:00 (1789686180) [12773.828342] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12776.020931] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 19:03:05 (1789686185) [12791.273641] Key type .llcrypt unregistered [12791.277948] Key type ._llcrypt unregistered [12801.197931] Key type ._llcrypt registered [12801.201256] Key type .llcrypt registered [12801.941757] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12801.961965] alg: No test for adler32 (adler32-zlib) [12803.236553] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [12803.482681] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [12805.193542] Key type lgssc registered [12806.747882] Lustre: Echo OBD driver; http://www.lustre.org/ [12887.501510] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12893.272525] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12921.798129] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12923.579483] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [12927.608948] Lustre: Unmounted lustre-client [12969.133178] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 19:06:18 (1789686378) [13013.133737] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13020.375512] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13058.966495] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13060.322338] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [13062.921547] Lustre: Unmounted lustre-client [13109.837110] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 19:08:39 (1789686519) [13118.879835] LNet: 1 local NIs in recovery (showing 1): 192.168.201.49@tcp [13721.881799] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13724.690532] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13748.246916] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13887.264507] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 19:21:36 (1789687296) [13899.654218] Key type lgssc unregistered [13899.992260] LNet: 289922:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13900.013966] LNetError: 289922:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13900.038180] LNet: Removed LNI 192.168.201.49@tcp [13900.914165] Key type .llcrypt unregistered [13900.916824] Key type ._llcrypt unregistered [14005.649104] Key type ._llcrypt registered [14005.655155] Key type .llcrypt registered [14006.278537] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14006.299920] alg: No test for adler32 (adler32-zlib) [14007.547851] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [14007.978668] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [14009.775470] Key type lgssc registered [14011.095573] Lustre: Echo OBD driver; http://www.lustre.org/ [14111.484274] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14117.919248] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14143.774388] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14180.574868] Key type lgssc unregistered [14180.824423] LNet: 293615:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14180.832580] LNetError: 293615:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14180.850136] LNet: Removed LNI 192.168.201.49@tcp [14181.462126] Key type .llcrypt unregistered [14181.463583] Key type ._llcrypt unregistered [14219.373211] Key type ._llcrypt registered [14219.375452] Key type .llcrypt registered [14221.097313] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 19:27:10 (1789687630) [14244.522316] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14244.547347] alg: No test for adler32 (adler32-zlib) [14245.662197] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [14245.986649] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [14247.696810] Key type lgssc registered [14249.404856] Lustre: Echo OBD driver; http://www.lustre.org/ [14302.140955] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 19:28:31 (1789687711) [14314.963306] Key type lgssc unregistered [14315.236438] LNet: 297170:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14315.246512] LNetError: 297170:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14315.268377] LNet: Removed LNI 192.168.201.49@tcp [14316.115980] Key type .llcrypt unregistered [14316.120716] Key type ._llcrypt unregistered [14329.177813] Key type ._llcrypt registered [14329.198811] Key type .llcrypt registered [14329.652918] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14329.671181] alg: No test for adler32 (adler32-zlib) [14330.955805] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [14331.251825] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [14332.911312] Key type lgssc registered [14334.272802] Lustre: Echo OBD driver; http://www.lustre.org/ [14396.471932] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14402.813795] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14426.932906] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14745.387338] LNet: Added LNI 192.168.201.49@tcp50 [8/256/0/180] [14747.510537] LNet: Removed LNI 192.168.201.49@tcp [14749.764918] Lustre: 301568:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff98e5c78d2000: config has no valid NIDs, force dynamic NIDs [14750.967896] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [14751.161686] Lustre: Unmounted lustre-client [14754.244545] Key type lgssc unregistered [14754.692626] LNet: 301826:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14754.697716] LNetError: 301826:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14754.717247] LNet: Removed LNI 192.168.201.49@tcp50 [14755.438882] Key type .llcrypt unregistered [14755.445322] Key type ._llcrypt unregistered [14774.832695] Key type ._llcrypt registered [14774.845445] Key type .llcrypt registered [14775.558838] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14775.577691] alg: No test for adler32 (adler32-zlib) [14776.659583] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [14776.998213] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [14778.745632] Key type lgssc registered [14780.212938] Lustre: Echo OBD driver; http://www.lustre.org/ [14842.164254] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14848.350936] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14856.253572] LNet: Added LNI 192.168.201.49@tcp50 [8/256/0/180] [14857.227775] LNet: Removed LNI 192.168.201.49@tcp [14858.448159] Lustre: 304513:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff98e5c5ab6800: config has no valid NIDs, force dynamic NIDs [14859.680455] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [14860.400531] Lustre: Unmounted lustre-client [14905.463825] Key type lgssc unregistered [14905.913833] LNet: 305382:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14905.919476] LNetError: 305382:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14905.935333] LNet: Removed LNI 192.168.201.49@tcp50 [14906.654688] Key type .llcrypt unregistered [14906.658967] Key type ._llcrypt unregistered [14920.139318] Key type ._llcrypt registered [14920.148680] Key type .llcrypt registered [14921.844505] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 19:38:51 (1789688331) [14941.830437] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14941.880442] alg: No test for adler32 (adler32-zlib) [14943.159959] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [14943.464764] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [14945.175583] Key type lgssc registered [14946.565694] Lustre: Echo OBD driver; http://www.lustre.org/ [15031.256384] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15037.871242] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15065.146366] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15096.500952] Key type lgssc unregistered [15096.829145] LNet: 310125:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15096.845777] LNetError: 310125:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15096.870469] LNet: Removed LNI 192.168.201.49@tcp [15097.586356] Key type .llcrypt unregistered [15097.588788] Key type ._llcrypt unregistered [15107.712915] Key type ._llcrypt registered [15107.716399] Key type .llcrypt registered [15109.214782] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 19:41:58 (1789688518) [15111.974237] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15111.985457] alg: No test for adler32 (adler32-zlib) [15113.153546] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [15113.519231] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [15115.223513] Key type lgssc registered [15116.343759] Lustre: Echo OBD driver; http://www.lustre.org/ [15167.911281] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15174.792257] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15197.085150] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15198.815633] Lustre: Mounted lustre-client - version 2.17.58_39_g9373f0b [15263.124476] Lustre: Mounted fs15246-client - version 2.17.58_39_g9373f0b [15279.412470] Lustre: Unmounted fs15246-client [15308.066123] Lustre: Unmounted lustre-client [15338.947409] Key type lgssc unregistered [15339.264514] LNet: 314984:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15339.272576] LNetError: 314984:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15339.292203] LNet: Removed LNI 192.168.201.49@tcp [15340.311757] Key type .llcrypt unregistered [15340.315162] Key type ._llcrypt unregistered [15351.619544] Key type ._llcrypt registered [15351.621898] Key type .llcrypt registered [15353.339185] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 19:46:02 (1789688762) [15355.321172] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15355.338565] alg: No test for adler32 (adler32-zlib) [15356.420616] Lustre: Lustre: Build Version: 2.17.58_39_g9373f0b [15356.756427] LNet: Added LNI 192.168.201.49@tcp [8/256/0/180] [15358.559538] Key type lgssc registered [15360.137379] Lustre: Echo OBD driver; http://www.lustre.org/ [15494.249333] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15499.469351] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15522.198398] Lustre: DEBUG MARKER: oleg149-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15622.525656] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15339 sec ========= 19:50:32 (1789689032) [15624.159774] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 19:50:34 (1789689034) === [15628.118932] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 19:50:37 (1789689037) === [15666.118434] Key type lgssc unregistered [15666.442931] LNet: 324238:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15666.450956] LNetError: 324238:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15666.487404] LNet: Removed LNI 192.168.201.49@tcp [15667.537136] Key type .llcrypt unregistered [15667.539733] Key type ._llcrypt unregistered