[ 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 435672317 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001017] APIC: Switch to symmetric I/O mode setup [ 0.002429] x2apic enabled [ 0.003000] Switched APIC routing to physical x2apic. [ 0.003025] kvm-guest: setup PV IPIs [ 0.007388] ..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.009022] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.010019] pid_max: default: 32768 minimum: 301 [ 0.012109] LSM: Security Framework initializing [ 0.013072] Yama: becoming mindful. [ 0.014062] SELinux: Initializing. [ 0.015093] *** VALIDATE selinux *** [ 0.023734] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.028663] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.030140] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031129] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.032147] *** VALIDATE tmpfs *** [ 0.034031] *** VALIDATE proc *** [ 0.035329] *** VALIDATE cgroup *** [ 0.036015] *** VALIDATE cgroup2 *** [ 0.037327] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038184] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.039014] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.040059] Spectre V2 : User space: Vulnerable [ 0.041017] Speculative Store Bypass: Vulnerable [ 0.044748] debug: unmapping init [mem 0xffffffffae459000-0xffffffffae460fff] [ 0.046836] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.047970] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.048041] ... version: 2 [ 0.049020] ... bit width: 48 [ 0.050019] ... generic registers: 4 [ 0.051021] ... value mask: 0000ffffffffffff [ 0.052021] ... max period: 00007fffffffffff [ 0.053023] ... fixed-purpose events: 3 [ 0.054017] ... event mask: 000000070000000f [ 0.056281] rcu: Hierarchical SRCU implementation. [ 0.058774] smp: Bringing up secondary CPUs ... [ 0.059704] x86: Booting SMP configuration: [ 0.060053] .... node #0, CPUs: #1 #2 #3 [ 0.064097] smp: Brought up 1 node, 4 CPUs [ 0.066027] smpboot: Max logical packages: 1 [ 0.067020] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.211474] node 0 deferred pages initialised in 141ms [ 0.215143] devtmpfs: initialized [ 0.217413] x86/mm: Memory block size: 128MB [ 0.221427] gcov: version magic: 0x41383552 [ 0.225395] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.226115] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.227409] pinctrl core: initialized pinctrl subsystem [ 0.229396] [ 0.230009] ************************************************************* [ 0.233013] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.236015] ** ** [ 0.239013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.243015] ** ** [ 0.246014] ** This means that this kernel is built to expose internal ** [ 0.249015] ** IOMMU data structures, which may compromise security on ** [ 0.251013] ** your system. ** [ 0.254015] ** ** [ 0.257026] ** If you see this message and you are not debugging the ** [ 0.262017] ** kernel, report this immediately to your vendor! ** [ 0.264025] ** ** [ 0.268016] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.271013] ************************************************************* [ 0.274748] NET: Registered protocol family 16 [ 0.276433] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.279063] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.282063] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.286097] cpuidle: using governor menu [ 0.287871] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.291420] PCI: Using configuration type 1 for base access [ 0.293293] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.303165] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.304044] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.306051] cryptd: max_cpu_qlen set to 1000 [ 0.308285] ACPI: Added _OSI(Module Device) [ 0.309106] ACPI: Added _OSI(Processor Device) [ 0.310014] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.312034] ACPI: Added _OSI(Processor Aggregator Device) [ 0.318270] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.327682] ACPI: Interpreter enabled [ 0.329056] ACPI: PM: (supports S0 S3 S4 S5) [ 0.330021] ACPI: Using IOAPIC for interrupt routing [ 0.332176] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.338450] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.348686] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.351060] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.354030] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.357098] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.362673] acpiphp: Slot [2] registered [ 0.364265] acpiphp: Slot [5] registered [ 0.366261] acpiphp: Slot [6] registered [ 0.368169] acpiphp: Slot [3] registered [ 0.370125] acpiphp: Slot [4] registered [ 0.371214] acpiphp: Slot [7] registered [ 0.373136] acpiphp: Slot [8] registered [ 0.374133] acpiphp: Slot [9] registered [ 0.376222] acpiphp: Slot [10] registered [ 0.377124] acpiphp: Slot [11] registered [ 0.379121] acpiphp: Slot [12] registered [ 0.380130] acpiphp: Slot [13] registered [ 0.382150] acpiphp: Slot [14] registered [ 0.383173] acpiphp: Slot [15] registered [ 0.385149] acpiphp: Slot [16] registered [ 0.387157] acpiphp: Slot [17] registered [ 0.388124] acpiphp: Slot [18] registered [ 0.390140] acpiphp: Slot [19] registered [ 0.391225] acpiphp: Slot [20] registered [ 0.393135] acpiphp: Slot [21] registered [ 0.394131] acpiphp: Slot [22] registered [ 0.396141] acpiphp: Slot [23] registered [ 0.397193] acpiphp: Slot [24] registered [ 0.399135] acpiphp: Slot [25] registered [ 0.400195] acpiphp: Slot [26] registered [ 0.402137] acpiphp: Slot [27] registered [ 0.404146] acpiphp: Slot [28] registered [ 0.405231] acpiphp: Slot [29] registered [ 0.407280] acpiphp: Slot [30] registered [ 0.409198] acpiphp: Slot [31] registered [ 0.411095] PCI host bridge to bus 0000:00 [ 0.412029] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.414074] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.417036] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.419030] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.422034] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.423000] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.423134] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.426191] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.430568] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.438019] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.442059] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.445038] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.447022] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.449026] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.452516] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.455933] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.458044] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.460821] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.468018] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.480025] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.484027] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.489907] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.498019] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.510017] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.544021] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.554030] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.564024] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.574022] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.595020] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.608385] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.612855] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.616598] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.619663] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.622428] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.629048] iommu: Default domain type: Passthrough [ 0.630722] SCSI subsystem initialized [ 0.633204] ACPI: bus type USB registered [ 0.635160] usbcore: registered new interface driver usbfs [ 0.638161] usbcore: registered new interface driver hub [ 0.640122] usbcore: registered new device driver usb [ 0.642225] pps_core: LinuxPPS API ver. 1 registered [ 0.645018] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.648084] PTP clock support registered [ 0.651239] EDAC MC: Ver: 3.0.0 [ 0.657102] PCI: Using ACPI for IRQ routing [ 0.659021] NetLabel: Initializing [ 0.660017] NetLabel: domain hash size = 128 [ 0.662016] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.664105] NetLabel: unlabeled traffic allowed by default [ 0.667107] vgaarb: loaded [ 0.669292] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.670017] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.677330] clocksource: Switched to clocksource kvm-clock [ 0.804718] VFS: Disk quotas dquot_6.6.0 [ 0.806349] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.809201] *** VALIDATE ramfs *** [ 0.810671] *** VALIDATE hugetlbfs *** [ 0.812433] pnp: PnP ACPI init [ 0.815180] pnp: PnP ACPI: found 6 devices [ 0.837410] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.846257] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.849063] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.851495] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.854466] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.859663] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.862828] NET: Registered protocol family 2 [ 0.866750] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.875927] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.879768] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.885276] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.889208] TCP: Hash tables configured (established 65536 bind 65536) [ 0.892505] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.895918] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.899054] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.902229] NET: Registered protocol family 1 [ 0.905186] RPC: Registered named UNIX socket transport module. [ 0.906867] RPC: Registered udp transport module. [ 0.908154] RPC: Registered tcp transport module. [ 0.910184] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.912984] NET: Registered protocol family 44 [ 0.952578] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.956308] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.959301] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.962581] PCI: CLS 0 bytes, default 64 [ 0.974596] Unpacking initramfs... [ 2.549976] debug: unmapping init [mem 0xffff89ad7cc64000-0xffff89ad7ffcffff] [ 2.556233] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.558081] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.561093] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 3.145233] Initialise system trusted keyrings [ 3.147331] Key type blacklist registered [ 3.149355] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 3.160857] zbud: loaded [ 3.166980] *** VALIDATE nfs *** [ 3.168064] *** VALIDATE nfs4 *** [ 3.169846] pstore: using deflate compression [ 3.174244] Platform Keyring initialized [ 3.313179] NET: Registered protocol family 38 [ 3.315722] Key type asymmetric registered [ 3.317671] Asymmetric key parser 'x509' registered [ 3.319955] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 3.323472] io scheduler mq-deadline registered [ 3.325337] io scheduler kyber registered [ 3.327798] io scheduler bfq registered [ 3.329762] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 3.332899] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 3.335643] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.338807] ACPI: Power Button [PWRF] [ 3.344508] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 3.351232] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 3.372856] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.414344] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 3.449186] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.455555] Non-volatile memory driver v1.3 [ 3.457440] Linux agpgart interface v0.103 [ 3.493657] virtio_blk virtio1: [vda] 150040 512-byte logical blocks (76.8 MB/73.3 MiB) [ 3.496952] vda: detected capacity change from 0 to 76820480 [ 3.521432] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.525381] vdb: detected capacity change from 0 to 1073741824 [ 3.537086] libphy: Fixed MDIO Bus: probed [ 3.548795] usbcore: registered new interface driver usbserial_generic [ 3.555068] usbserial: USB Serial support registered for generic [ 3.557887] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.563503] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.565933] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.569510] mousedev: PS/2 mouse device common for all mice [ 3.573512] rtc_cmos 00:05: RTC can wake from S4 [ 3.574946] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.581489] rtc_cmos 00:05: registered as rtc0 [ 3.586719] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.590036] intel_pstate: CPU model not supported [ 3.593859] hid: raw HID events driver (C) Jiri Kosina [ 3.596394] usbcore: registered new interface driver usbhid [ 3.598260] usbhid: USB HID core driver [ 3.600154] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.600737] drop_monitor: Initializing network drop monitor service [ 3.607464] Initializing XFRM netlink socket [ 3.610873] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.614766] NET: Registered protocol family 10 [ 3.618622] Segment Routing with IPv6 [ 3.620514] NET: Registered protocol family 17 [ 3.623190] mpls_gso: MPLS GSO support [ 3.628705] RAS: Correctable Errors collector initialized. [ 3.631198] AVX version of gcm_enc/dec engaged. [ 3.633026] AES CTR mode by8 optimization enabled [ 3.754395] sched_clock: Marking stable (3754313090, 0)->(4698860867, -944547777) [ 3.758840] registered taskstats version 1 [ 3.761417] Loading compiled-in X.509 certificates [ 3.763863] zswap: loaded using pool lzo/zbud [ 3.806310] Key type big_key registered [ 3.829595] Key type encrypted registered [ 3.831226] ima: No TPM chip found, activating TPM-bypass! [ 3.833989] ima: Allocated hash algorithm: sha1 [ 3.836493] ima: No architecture policies found [ 3.838672] evm: Initialising EVM extended attributes: [ 3.841934] evm: security.selinux [ 3.843468] evm: security.ima [ 3.845366] evm: security.capability [ 3.846758] evm: HMAC attrs: 0x1 [ 3.850346] rtc_cmos 00:05: setting system clock to 2026-09-07 01:52:04 UTC (1788745924) [ 3.858546] debug: unmapping init [mem 0xffffffffaf403000-0xffffffffaf5fffff] [ 3.862456] debug: unmapping init [mem 0xffffffffae182000-0xffffffffae458fff] [ 3.869424] Write protecting the kernel read-only data: 28672k [ 3.876653] debug: unmapping init [mem 0xffffffffac803000-0xffffffffac9fffff] [ 3.881800] debug: unmapping init [mem 0xffffffffad114000-0xffffffffad1fffff] [ 3.968918] 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.979928] systemd[1]: Detected virtualization kvm. [ 3.982594] systemd[1]: Detected architecture x86-64. [ 3.984861] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 4.026262] systemd[1]: No hostname configured. [ 4.028953] systemd[1]: Set hostname to . [ 4.032724] random: systemd: uninitialized urandom read (16 bytes read) [ 4.036435] systemd[1]: Initializing machine ID from random generator. [ 4.147907] random: ln: uninitialized urandom read (6 bytes read) [ 4.283271] random: systemd: uninitialized urandom read (16 bytes read) [ 4.286395] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 4.293951] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 4.300639] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Slices. [ OK ] Reached target Timers. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Swap. [ OK ] Listening on Journal Socket. [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Sockets. Starting Apply Kernel Variables... Starting Journal Service... Starting Setup Virtual Console... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Paths. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Started Apply Kernel Variables. [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Create Volatile Files and Directories. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 5.556411] device-mapper: uevent: version 1.0.3 [ 5.560289] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Startin[ 6.849211] virtio_net virtio0 ens2: renamed from eth0 g dracut initqueue hook... [ 7.109985] scsi host0: ata_piix [ 7.186713] scsi host1: ata_piix [ 7.189667] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 7.198935] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 12.359990] random: crng init done [ 12.364370] random: 7 urandom warning(s) missed due to ratelimiting [ 14.229485] dracut-initqueue[590]: RTNETLINK answers: File exists 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. [ 15.185133] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped target Basic System. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ 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 ] 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... [ 16.868495] printk: systemd: 26 output lines suppressed due to ratelimiting [ 17.302871] SELinux: Disabled at runtime. [ 17.377314] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 17.389313] systemd[1]: Detected virtualization kvm. [ 17.391806] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 18.339838] systemd[1]: initrd-switch-root.service: Succeeded. [ 18.343574] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 18.357906] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 18.360427] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 18.363365] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 18.373677] systemd[1]: Starting Journal Service... Starting Journal Service... [ 18.382889] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Listening on Process Core Dump Socket. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Created slice system-getty.slice. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Reached target rpc_pipefs.target. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Listening on udev Control Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting Huge Pages File System... Mounting Kernel Debug File System... [ OK ] Stopped target Switch Root. Activating swap /dev/disk/by-label/SWAP... [ OK ] Stopped target Initrd File Systems. Mounting POSIX Message Queue File System... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. [ 18.632970] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Created slice User and Session Slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. Starting Apply Kernel Variables... [ OK ] Reached target Slices. [ OK ] Stopped target Initrd Root File System. [ OK ] Started Journal Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Apply Kernel Variables. Starting Configure read-only root support... [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 19.489828] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 20.230705] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 20.311000] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 20.609975] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 20.662409] EDAC sbridge: Ver: 1.1.2 [ 23.027326] Key type dns_resolver registered [ 23.445154] NFS: Registering the id_resolver key type [ 23.447957] Key type id_resolver registered [ 23.450550] Key type id_legacy registered [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Rebuild Dynamic Linker Cache... Starting Create Volatile Files and Directories... [ OK ] Started Load/Save Random Seed. [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Reached target Timers. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. Starting Login Service... Starting Network Manager... [ OK ] Started irqbalance daemon. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting GSSAPI Proxy Daemon... Starting Network Manager Wait Online... [ OK ] Started OpenSSH server daemon. [ OK ] Started Login Service. Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Serial Getty on ttyS1. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg651-client login: [ 73.076017] hrtimer: interrupt took 7006515 ns [ 86.008340] libcfs: loading out-of-tree module taints kernel. [ 86.132045] Key type ._llcrypt registered [ 86.133642] Key type .llcrypt registered [ 86.908852] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 86.964159] alg: No test for adler32 (adler32-zlib) [ 88.990981] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 89.857719] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 91.680361] Key type lgssc registered [ 93.648272] Lustre: Echo OBD driver; http://www.lustre.org/ [ 279.322767] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 284.862194] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 302.623074] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing check_logdir /tmp/testlogs/ [ 305.121489] Lustre: lustre-OST0000-osc-ffff89adc4e5f800: disconnect after 23s idle [ 308.129019] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing yml_node [ 313.323381] Lustre: DEBUG MARKER: Client: 2.17.58.39 [ 316.648394] Lustre: DEBUG MARKER: MDS: 2.17.58.39 [ 319.638716] Lustre: DEBUG MARKER: OSS: 2.17.58.39 [ 321.381575] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sun Sep 6 21:57:20 EDT 2026 [ 342.088282] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 343.899797] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 347.546819] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 357.846648] Lustre: Unmounted lustre-client [ 503.995431] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 510.019662] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 534.398394] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 580.738280] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 22:01:39 (1788746499) [ 583.197415] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 585.074326] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 22:01:44 (1788746504) [ 617.308294] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 623.059721] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 644.888134] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 645.581928] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 651.382820] Lustre: Unmounted lustre-client [ 679.897261] Key type lgssc unregistered [ 680.134759] LNet: 15080:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 680.145495] LNetError: 15080:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 680.155273] LNet: Removed LNI 192.168.206.51@tcp [ 680.907152] Key type .llcrypt unregistered [ 680.910069] Key type ._llcrypt unregistered [ 695.601800] Key type ._llcrypt registered [ 695.605426] Key type .llcrypt registered [ 696.953078] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 22:03:35 (1788746615) [ 698.423955] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 698.459189] alg: No test for adler32 (adler32-zlib) [ 699.642660] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 699.866711] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 701.528389] Key type lgssc registered [ 702.569658] Lustre: Echo OBD driver; http://www.lustre.org/ [ 767.819602] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 850.139707] Lustre: Unmounted lustre-client [ 875.277405] Key type lgssc unregistered [ 875.555071] LNet: 18900:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 875.571360] LNetError: 18900:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 875.615293] LNet: Removed LNI 192.168.206.51@tcp [ 876.285858] Key type .llcrypt unregistered [ 876.291599] Key type ._llcrypt unregistered [ 884.615316] Key type ._llcrypt registered [ 884.617760] Key type .llcrypt registered [ 885.753148] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 22:06:45 (1788746805) [ 887.728114] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 887.765764] alg: No test for adler32 (adler32-zlib) [ 888.817322] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 889.058407] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 890.736256] Key type lgssc registered [ 891.792775] Lustre: Echo OBD driver; http://www.lustre.org/ [ 931.220233] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 935.893565] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 952.665594] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 959.508041] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 967.953616] Lustre: Unmounted lustre-client [ 1000.428188] Key type lgssc unregistered [ 1000.616902] LNet: 22496:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1000.629585] LNetError: 22496:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1000.655168] LNet: Removed LNI 192.168.206.51@tcp [ 1001.230837] Key type .llcrypt unregistered [ 1001.234407] Key type ._llcrypt unregistered [ 1009.125120] Key type ._llcrypt registered [ 1009.127982] Key type .llcrypt registered [ 1010.333341] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 22:08:49 (1788746929) [ 1012.341380] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1012.357617] alg: No test for adler32 (adler32-zlib) [ 1013.373068] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 1013.594621] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1015.232603] Key type lgssc registered [ 1016.103346] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1053.603220] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1057.569375] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1073.730721] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1079.330163] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 1084.651667] Lustre: Unmounted lustre-client [ 1107.936984] Key type lgssc unregistered [ 1108.115711] LNet: 25677:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1108.119867] LNetError: 25677:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1108.144207] LNet: Removed LNI 192.168.206.51@tcp [ 1108.574271] Key type .llcrypt unregistered [ 1108.576074] Key type ._llcrypt unregistered [ 1118.277151] Key type ._llcrypt registered [ 1118.279339] Key type .llcrypt registered [ 1119.132463] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 22:10:38 (1788747038) [ 1120.644897] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1120.677757] alg: No test for adler32 (adler32-zlib) [ 1121.658736] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 1121.828214] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1123.464223] Key type lgssc registered [ 1124.232212] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1159.879413] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1164.321167] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1180.431567] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1191.456489] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 1196.531063] Lustre: lustre-MDT0000-mdc-ffff89adc6ecd800: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1201.643388] Lustre: lustre-MDT0001-mdc-ffff89adc6ecd800: Connection to lustre-MDT0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1204.237972] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1214.519362] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 1214.558457] Lustre: Unmounted lustre-client [ 1229.945613] Key type lgssc unregistered [ 1230.119680] LNet: 29323:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1230.126114] LNetError: 29323:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1230.142055] LNet: Removed LNI 192.168.206.51@tcp [ 1230.574187] Key type .llcrypt unregistered [ 1230.576910] Key type ._llcrypt unregistered [ 1240.648328] Key type ._llcrypt registered [ 1240.650453] Key type .llcrypt registered [ 1241.614182] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 22:12:41 (1788747161) [ 1243.446524] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1243.487193] alg: No test for adler32 (adler32-zlib) [ 1244.477915] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 1244.696152] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1246.344212] Key type lgssc registered [ 1247.260740] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1280.545702] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1283.956309] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1297.736724] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1299.305189] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 1304.556165] Lustre: lustre-OST0000-osc-ffff89add0c9b000: Connection to lustre-OST0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1309.902225] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1320.205126] Lustre: Unmounted lustre-client [ 1343.645684] Key type lgssc unregistered [ 1343.815478] LNet: 32926:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1343.827283] LNetError: 32926:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1343.847655] LNet: Removed LNI 192.168.206.51@tcp [ 1344.390477] Key type .llcrypt unregistered [ 1344.394626] Key type ._llcrypt unregistered [ 1355.353595] Key type ._llcrypt registered [ 1355.355702] Key type .llcrypt registered [ 1356.307756] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 22:14:35 (1788747275) [ 1357.968426] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1358.002185] alg: No test for adler32 (adler32-zlib) [ 1358.979951] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 1359.157257] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1360.801717] Key type lgssc registered [ 1361.711226] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1398.921504] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1402.958248] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1418.328415] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1429.036402] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 1431.800726] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1434.875111] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1445.853794] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-0622h16m05s [ 1447.142646] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1449.446208] Lustre: lustre-MDT0000-mdc-ffff89adc6a22800: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1456.163635] LustreError: 36707:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff89adc6a22800: can't stat MDS #0: rc = -19 [ 1457.307765] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1466.850708] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 1466.876359] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0x6ae1e6992670f865 to 0x6ae1e6992670fc08 [ 1466.884820] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 1467.943719] LustreError: lustre-MDT0000-mdc-ffff89adc6a22800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1467.959877] Lustre: lustre-MDT0000-mdc-ffff89adc6a22800: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 1468.284929] Lustre: DEBUG MARKER: Wait for df (36707) ... [ 1469.586515] Lustre: DEBUG MARKER: done [ 1471.688567] Lustre: Unmounted lustre-client [ 1497.826809] Key type lgssc unregistered [ 1498.036379] LNet: 37719:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1498.054248] LNetError: 37719:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1498.070358] LNet: Removed LNI 192.168.206.51@tcp [ 1498.666055] Key type .llcrypt unregistered [ 1498.671996] Key type ._llcrypt unregistered [ 1525.328660] Key type ._llcrypt registered [ 1525.330398] Key type .llcrypt registered [ 1526.760809] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 22:17:25 (1788747445) [ 1529.892540] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1529.941740] alg: No test for adler32 (adler32-zlib) [ 1530.932331] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 1531.172196] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1532.840682] Key type lgssc registered [ 1534.214966] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1578.600874] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1582.907141] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1600.214142] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1601.710217] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 1605.693243] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-0622h18m44s [ 1606.948179] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1613.077133] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1615.433992] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1635.808808] Lustre: 41850:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788747536/real 1788747536] req@00000000d238e7cc x1875637647186048/t0(0) o101->lustre-MDT0000-mdc-ffff89adc819d000@192.168.206.151@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788747556 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1635.831727] Lustre: lustre-MDT0000-mdc-ffff89adc819d000: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1635.861934] Lustre: lustre-MDT0000-mdc-ffff89adc819d000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 1656.892321] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1660.135320] Lustre: DEBUG MARKER: done [ 1663.262411] Lustre: Unmounted lustre-client [ 1686.651863] Key type lgssc unregistered [ 1686.816772] LNet: 42735:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1686.825308] LNetError: 42735:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1686.836183] LNet: Removed LNI 192.168.206.51@tcp [ 1687.377873] Key type .llcrypt unregistered [ 1687.380574] Key type ._llcrypt unregistered [ 1707.485844] Key type ._llcrypt registered [ 1707.487973] Key type .llcrypt registered [ 1708.229547] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 22:20:28 (1788747628) [ 1709.274844] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1710.493256] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 22:20:30 (1788747630) [ 1712.971546] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1712.986796] alg: No test for adler32 (adler32-zlib) [ 1713.949505] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 1714.117056] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1715.729335] Key type lgssc registered [ 1716.530116] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1739.898366] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 22:20:59 (1788747659) [ 1764.196030] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1768.732459] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1785.438642] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1788.009498] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 1790.774974] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1793.620767] Lustre: Unmounted lustre-client [ 1804.572764] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1847.618590] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1851.575769] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1852.073782] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 1854.637216] Lustre: Unmounted lustre-client [ 1909.993901] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1917.724317] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1918.724828] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 1923.108632] Lustre: Unmounted lustre-client [ 1944.213915] Lustre: DEBUG MARKER: files compared the same [ 1966.553576] Key type lgssc unregistered [ 1966.776056] LNet: 50340:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1966.779873] LNetError: 50340:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1966.794473] LNet: Removed LNI 192.168.206.51@tcp [ 1967.442706] Key type .llcrypt unregistered [ 1967.446551] Key type ._llcrypt unregistered [ 1982.472535] Key type ._llcrypt registered [ 1982.474424] Key type .llcrypt registered [ 1983.745392] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 22:25:02 (1788747902) [ 1986.269782] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1986.284896] alg: No test for adler32 (adler32-zlib) [ 1987.450492] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 1987.665564] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 1989.400397] Key type lgssc registered [ 1990.480716] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2033.759592] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2038.937470] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2055.713683] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2061.333048] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 2064.173111] Lustre: Unmounted lustre-client [ 2089.731412] Key type lgssc unregistered [ 2089.993347] LNet: 53915:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2090.009910] LNetError: 53915:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2090.030072] LNet: Removed LNI 192.168.206.51@tcp [ 2090.536375] Key type .llcrypt unregistered [ 2090.539869] Key type ._llcrypt unregistered [ 2104.293853] Key type ._llcrypt registered [ 2104.298501] Key type .llcrypt registered [ 2105.378169] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 22:27:04 (1788748024) [ 2106.918197] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2106.935290] alg: No test for adler32 (adler32-zlib) [ 2107.921215] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 2108.092959] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 2109.768293] Key type lgssc registered [ 2110.815679] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2194.290586] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2231.365435] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2237.577599] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2272.602824] Key type lgssc unregistered [ 2272.863516] LNet: 57407:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2272.879584] LNetError: 57407:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2272.902270] LNet: Removed LNI 192.168.206.51@tcp [ 2273.506518] Key type .llcrypt unregistered [ 2273.509747] Key type ._llcrypt unregistered [ 2287.879276] Key type ._llcrypt registered [ 2287.881508] Key type .llcrypt registered [ 2289.242916] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 22:30:08 (1788748208) [ 2292.624964] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2292.644029] alg: No test for adler32 (adler32-zlib) [ 2293.738518] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 2293.977197] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 2295.657943] Key type lgssc registered [ 2296.759546] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2373.352960] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 2380.883927] Lustre: Unmounted lustre-client [ 2425.646156] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 22:32:24 (1788748344) [ 2539.634923] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2557.980229] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 2565.199573] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2565.205704] LustreError: 63873:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff89adc5eaf800: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2565.220423] Lustre: 58388:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.151@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2575.520873] Lustre: Unmounted lustre-client [ 2628.240549] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 22:35:47 (1788748547) [ 2639.733717] Key type lgssc unregistered [ 2640.005410] LNet: 65091:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2640.010390] LNetError: 65091:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2640.037724] LNet: Removed LNI 192.168.206.51@tcp [ 2640.793656] Key type .llcrypt unregistered [ 2640.796883] Key type ._llcrypt unregistered [ 2654.871111] Key type ._llcrypt registered [ 2654.878192] Key type .llcrypt registered [ 2655.348553] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2655.361719] alg: No test for adler32 (adler32-zlib) [ 2656.437435] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 2656.682718] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 2658.320208] Key type lgssc registered [ 2659.690441] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2704.236974] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2709.567839] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2729.228514] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2730.918369] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 2734.918270] Lustre: Unmounted lustre-client [ 2762.942206] Key type lgssc unregistered [ 2763.158834] LNet: 68092:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2763.187692] LNetError: 68092:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2763.205801] LNet: Removed LNI 192.168.206.51@tcp [ 2764.035337] Key type .llcrypt unregistered [ 2764.038240] Key type ._llcrypt unregistered [ 2773.081517] Key type ._llcrypt registered [ 2773.087070] Key type .llcrypt registered [ 2773.417982] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2773.432442] alg: No test for adler32 (adler32-zlib) [ 2774.467746] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 2774.680908] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 2776.369343] Key type lgssc registered [ 2777.469436] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2878.393887] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2883.629890] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2901.054470] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2903.682234] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 2906.122506] Lustre: Unmounted lustre-client [ 2928.920566] Key type lgssc unregistered [ 2929.132370] LNet: 71515:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2929.141673] LNetError: 71515:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2929.157365] LNet: Removed LNI 192.168.206.51@tcp [ 2929.639906] Key type .llcrypt unregistered [ 2929.643630] Key type ._llcrypt unregistered [ 2940.792222] Key type ._llcrypt registered [ 2940.796140] Key type .llcrypt registered [ 2941.790898] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 22:41:01 (1788748861) [ 2943.616843] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2943.656640] alg: No test for adler32 (adler32-zlib) [ 2944.669560] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 2944.858285] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 2946.504253] Key type lgssc registered [ 2947.348837] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2982.580294] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2986.431705] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3001.597985] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3012.623936] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 3016.882808] Lustre: Unmounted lustre-client [ 3017.232767] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 3019.273410] Lustre: Unmounted lustre-client [ 3046.830494] Key type lgssc unregistered [ 3047.002416] LNet: 75190:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3047.017587] LNetError: 75190:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3047.035150] LNet: Removed LNI 192.168.206.51@tcp [ 3047.573964] Key type .llcrypt unregistered [ 3047.577070] Key type ._llcrypt unregistered [ 3055.917724] Key type ._llcrypt registered [ 3055.923191] Key type .llcrypt registered [ 3056.218808] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3056.230468] alg: No test for adler32 (adler32-zlib) [ 3057.217129] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 3057.411088] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3059.080226] Key type lgssc registered [ 3059.877454] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3091.645699] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3095.652274] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3108.904744] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3110.331546] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 3113.188720] Lustre: Unmounted lustre-client [ 3134.409540] Key type lgssc unregistered [ 3134.602671] LNet: 78214:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3134.607672] LNetError: 78214:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3134.618432] LNet: Removed LNI 192.168.206.51@tcp [ 3135.054611] Key type .llcrypt unregistered [ 3135.056931] Key type ._llcrypt unregistered [ 3144.775370] Key type ._llcrypt registered [ 3144.777103] Key type .llcrypt registered [ 3145.627273] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 22:44:25 (1788749065) [ 3147.130525] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3147.155089] alg: No test for adler32 (adler32-zlib) [ 3148.128323] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 3148.331087] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3149.992241] Key type lgssc registered [ 3150.854565] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3182.877606] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3186.660989] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3201.017293] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3202.452714] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 3210.805911] Lustre: lustre: root_squash is set to 0:0 [ 3210.827528] Lustre: lustre: nosquash_nids is cleared [ 3220.478675] Lustre: lustre: root_squash is set to 500:500 [ 3229.728547] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.51@tcp 192.168.0.[2,10]@tcp [ 3235.482676] Lustre: lustre: nosquash_nids set to 192.168.206.51/24@tcp [ 3241.084799] Lustre: Unmounted lustre-client [ 3268.049513] Key type lgssc unregistered [ 3268.230655] LNet: 82197:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3268.241058] LNetError: 82197:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3268.251613] LNet: Removed LNI 192.168.206.51@tcp [ 3268.788079] Key type .llcrypt unregistered [ 3268.793200] Key type ._llcrypt unregistered [ 3278.715659] Key type ._llcrypt registered [ 3278.717261] Key type .llcrypt registered [ 3279.572914] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 22:46:39 (1788749199) [ 3281.086754] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3282.272968] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 22:46:41 (1788749201) [ 3283.838313] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3283.855859] alg: No test for adler32 (adler32-zlib) [ 3284.852201] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 3285.009370] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3286.672283] Key type lgssc registered [ 3287.581599] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3320.606924] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3324.429639] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3337.144912] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3338.486491] Lustre: lustre: root_squash is set to 500:500 [ 3338.500792] Lustre: lustre: nosquash_nids set to 192.168.206.51/24@tcp [ 3354.120401] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 3357.853653] Lustre: Unmounted lustre-client [ 3377.775364] Key type lgssc unregistered [ 3377.919831] LNet: 86147:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3377.923330] LNetError: 86147:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3377.936137] LNet: Removed LNI 192.168.206.51@tcp [ 3378.301907] Key type .llcrypt unregistered [ 3378.303216] Key type ._llcrypt unregistered [ 3385.625198] Key type ._llcrypt registered [ 3385.626710] Key type .llcrypt registered [ 3386.376240] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3387.262952] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 22:48:27 (1788749307) [ 3395.716993] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3395.727548] alg: No test for adler32 (adler32-zlib) [ 3396.642670] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 3396.755901] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3398.392278] Key type lgssc registered [ 3398.955886] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3439.253376] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3441.538693] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3453.317741] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3485.655228] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3488.255261] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3497.695319] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3506.961325] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 3523.206619] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff89add0aa7800.ost_server_uuid 50 [ 3523.902499] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff89add0aa7800.ost_server_uuid in FULL state after 0 sec [ 3524.103948] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 3525.663150] Lustre: Unmounted lustre-client [ 3526.196207] Lustre: Unmounted lustre-client [ 3557.330283] Key type lgssc unregistered [ 3557.473843] LNet: 93774:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3557.479638] LNetError: 93774:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3557.499472] LNet: Removed LNI 192.168.206.51@tcp [ 3557.874133] Key type .llcrypt unregistered [ 3557.875806] Key type ._llcrypt unregistered [ 3572.265271] Key type ._llcrypt registered [ 3572.266788] Key type .llcrypt registered [ 3572.865366] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 22:51:32 (1788749492) [ 3581.201314] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3581.241821] alg: No test for adler32 (adler32-zlib) [ 3582.140578] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 3582.268516] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3583.864273] Key type lgssc registered [ 3584.361893] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3625.264688] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3628.150799] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3638.960901] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3640.265349] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 3660.786065] Lustre: lustre-OST0000-osc-ffff89add0fec000: Connection to lustre-OST0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3661.104273] Lustre: lustre-OST0000-osc-ffff89add0fec000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 3661.792943] Lustre: 95127:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788749566/real 1788749566] req@000000009b7a7e60 x1875639797814400/t0(0) o400->lustre-OST0000-osc-ffff89add0fec000@192.168.206.151@tcp:28/4 lens 224/224 e 0 to 1 dl 1788749582 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3665.897871] Lustre: lustre-MDT0000-mdc-ffff89add0fec000: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 3666.912276] Lustre: 95128:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788749571/real 1788749571] req@000000003e253e57 x1875639797814912/t0(0) o400->lustre-OST0000-osc-ffff89add0fec000@192.168.206.151@tcp:28/4 lens 224/224 e 0 to 1 dl 1788749587 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3672.032236] Lustre: 95128:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788749576/real 1788749576] req@000000002392c021 x1875639797815424/t0(0) o400->lustre-OST0000-osc-ffff89add0fec000@192.168.206.151@tcp:28/4 lens 224/224 e 0 to 1 dl 1788749592 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 3681.261215] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 3681.273867] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0x6bcceb3cdf5035e5 to 0x6bcceb3cdf5038af [ 3681.282134] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 3683.089526] Lustre: lustre-MDT0000-mdc-ffff89add0fec000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 3683.993937] Lustre: Unmounted lustre-client [ 3703.597107] Key type lgssc unregistered [ 3703.736614] LNet: 99410:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3703.742906] LNetError: 99410:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3703.756444] LNet: Removed LNI 192.168.206.51@tcp [ 3704.123351] Key type .llcrypt unregistered [ 3704.125094] Key type ._llcrypt unregistered [ 3711.200711] Key type ._llcrypt registered [ 3711.201895] Key type .llcrypt registered [ 3711.905210] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 22:53:51 (1788749631) [ 3724.375375] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3724.387514] alg: No test for adler32 (adler32-zlib) [ 3725.300149] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 3725.420885] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 3727.040217] Key type lgssc registered [ 3727.639878] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3746.873438] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3789.901492] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3792.391989] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3802.949540] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3810.294926] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 3811.433397] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 3812.411646] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 22:55:32 (1788749732) [ 3927.782813] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3938.051774] Lustre: Unmounted lustre-client [ 3996.452727] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3998.818953] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4009.219654] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4041.054317] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 22:59:21 (1788749961) [ 4079.084304] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4081.276938] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4090.889997] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4096.506623] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 4097.762262] Lustre: Unmounted lustre-client [ 4117.645425] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 23:00:36 (1788750036) [ 4223.845494] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4227.718958] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4244.221896] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4244.743618] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 4247.674193] Lustre: Unmounted lustre-client [ 4271.746424] Key type lgssc unregistered [ 4271.957527] LNet: 122370:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4271.976925] LNetError: 122370:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4271.988916] LNet: Removed LNI 192.168.206.51@tcp [ 4272.763207] Key type .llcrypt unregistered [ 4272.764829] Key type ._llcrypt unregistered [ 4285.906630] Key type ._llcrypt registered [ 4285.908810] Key type .llcrypt registered [ 4287.213572] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 23:03:26 (1788750206) [ 4288.885427] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4288.967176] alg: No test for adler32 (adler32-zlib) [ 4289.941933] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 4290.135341] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 4291.800271] Key type lgssc registered [ 4292.737889] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4330.466719] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4335.180616] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4353.863922] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4359.758385] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 4372.866525] Lustre: Unmounted lustre-client [ 4399.267795] Key type lgssc unregistered [ 4399.500084] LNet: 125957:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4399.524414] LNetError: 125957:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4399.546815] LNet: Removed LNI 192.168.206.51@tcp [ 4400.238938] Key type .llcrypt unregistered [ 4400.242043] Key type ._llcrypt unregistered [ 4413.957482] Key type ._llcrypt registered [ 4413.959870] Key type .llcrypt registered [ 4415.196804] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 23:05:34 (1788750334) [ 4417.271333] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4417.348129] alg: No test for adler32 (adler32-zlib) [ 4418.343263] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 4418.552820] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 4420.200223] Key type lgssc registered [ 4421.275833] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4469.154486] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4474.582281] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4495.942291] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4498.848941] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 4515.459451] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff89add1d16000.ost_server_uuid 50 [ 4525.536153] Lustre: 126930:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788750429/real 1788750429] req@0000000020859495 x1875640675473280/t0(0) o400->lustre-OST0000-osc-ffff89add1d16000@192.168.206.151@tcp:28/4 lens 224/224 e 0 to 1 dl 1788750445 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4525.582576] Lustre: lustre-OST0000-osc-ffff89add1d16000: Connection to lustre-OST0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4528.170846] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 4529.632210] Lustre: 126929:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788750434/real 1788750434] req@00000000eb69ec2f x1875640675473792/t0(0) o400->lustre-OST0000-osc-ffff89add1d16000@192.168.206.151@tcp:28/4 lens 224/224 e 0 to 1 dl 1788750450 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4535.823932] Lustre: 126929:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788750440/real 1788750440] req@000000000d534d7d x1875640675474304/t0(0) o400->lustre-OST0000-osc-ffff89add1d16000@192.168.206.151@tcp:28/4 lens 224/224 e 0 to 1 dl 1788750456 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4540.367789] Lustre: Unmounted lustre-client [ 4562.072723] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 23:08:01 (1788750481) [ 4596.198968] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4604.590596] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4628.662212] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4653.304711] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4653.844230] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 4659.186849] Lustre: lustre-OST0000-osc-ffff89adc78ad000: Connection to lustre-OST0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4683.773586] Lustre: Unmounted lustre-client [ 4734.321062] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 23:10:53 (1788750653) [ 4772.990938] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4778.944073] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4803.850259] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4826.685860] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4827.542234] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 4832.774580] Lustre: lustre-OST0000-osc-ffff89adc7f4f800: Connection to lustre-OST0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4849.402682] Lustre: Unmounted lustre-client [ 4895.606974] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 23:13:34 (1788750814) [ 4989.554142] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4994.974365] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5018.580822] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5100.242594] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5104.851502] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5122.598088] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5146.460810] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 5188.594249] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5193.382925] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 5195.847835] Lustre: Unmounted lustre-client [ 5225.565101] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 23:19:05 (1788751145) [ 5253.367357] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5257.896349] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5272.892473] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5298.011769] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5332.097968] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 5370.448347] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5371.897585] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5378.035941] Lustre: lustre-OST0001-osc-ffff89adc95c1000: Connection to lustre-OST0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5391.027249] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5401.389975] Lustre: Unmounted lustre-client [ 5444.914265] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 23:22:44 (1788751364) [ 5470.695429] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5474.822721] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5489.155668] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5489.536063] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 5505.713836] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5506.755547] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 5516.684411] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff89adc5d27000.ost_server_uuid 50 [ 5517.668630] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff89adc5d27000.ost_server_uuid in FULL state after 0 sec [ 5519.667207] Lustre: Unmounted lustre-client [ 5519.902109] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 5519.905313] Lustre: Skipped 3 previous similar messages [ 5519.987676] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 5520.760602] LustreError: 149484:0:(sec.c:409:import_sec_validate_get()) import 0000000029575e89 (NEW) with no sec [ 5576.523852] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 23:24:56 (1788751496) [ 5600.069709] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5604.377451] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5621.210837] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5638.715310] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5639.119210] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 5639.271197] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 5649.688826] Lustre: Unmounted lustre-client [ 5649.695518] Lustre: Skipped 1 previous similar message [ 5691.946964] Key type lgssc unregistered [ 5692.198308] LNet: 152888:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5692.205450] LNetError: 152888:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5692.220610] LNet: Removed LNI 192.168.206.51@tcp [ 5693.116197] Key type .llcrypt unregistered [ 5693.120326] Key type ._llcrypt unregistered [ 5708.067787] Key type ._llcrypt registered [ 5708.071212] Key type .llcrypt registered [ 5709.252335] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 23:27:08 (1788751628) [ 5710.138970] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5710.236230] alg: No test for adler32 (adler32-zlib) [ 5711.255372] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 5711.422809] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 5713.056896] Key type lgssc registered [ 5714.073604] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5756.006228] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5760.413582] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5777.030107] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5793.203693] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5793.649679] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5794.785162] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 5803.533794] LustreError: lustre-MDT0001-mdc-ffff89adc593a000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 5803.558822] Lustre: lustre-MDT0001-mdc-ffff89adc593a000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 5809.279598] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5810.541882] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 5828.133849] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 5837.209197] Lustre: Unmounted lustre-client [ 5864.106069] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 23:29:43 (1788751783) [ 5946.604530] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5951.103393] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5970.842127] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5971.653882] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 5995.406181] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5997.168881] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6002.159579] Lustre: lustre-OST0001-osc-ffff89add0aa3000: Connection to lustre-OST0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6009.136773] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6019.528481] Lustre: Unmounted lustre-client [ 6052.214340] Key type lgssc unregistered [ 6052.455980] LNet: 162511:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6052.465320] LNetError: 162511:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6052.480307] LNet: Removed LNI 192.168.206.51@tcp [ 6053.011402] Key type .llcrypt unregistered [ 6053.014685] Key type ._llcrypt unregistered [ 6081.598887] Key type ._llcrypt registered [ 6081.605239] Key type .llcrypt registered [ 6082.952680] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 23:33:22 (1788752002) [ 6085.217394] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6085.243732] alg: No test for adler32 (adler32-zlib) [ 6086.362326] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 6086.668538] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 6088.400211] Key type lgssc registered [ 6089.478681] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6134.686507] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6140.080144] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6158.467610] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6160.029479] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 6203.667345] Lustre: Unmounted lustre-client [ 6237.062459] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6237.571853] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 6272.568567] Lustre: Unmounted lustre-client [ 6295.511736] Key type lgssc unregistered [ 6295.670774] LNet: 166952:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6295.677183] LNetError: 166952:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6295.688990] LNet: Removed LNI 192.168.206.51@tcp [ 6296.196752] Key type .llcrypt unregistered [ 6296.198971] Key type ._llcrypt unregistered [ 6305.868582] Key type ._llcrypt registered [ 6305.870636] Key type .llcrypt registered [ 6306.717884] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 23:37:06 (1788752226) [ 6308.120902] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6308.137384] alg: No test for adler32 (adler32-zlib) [ 6309.104408] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 6309.267514] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 6310.912833] Key type lgssc registered [ 6311.791766] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6346.417734] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6350.782909] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6365.062805] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6375.971604] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 6389.613861] Lustre: Unmounted lustre-client [ 6414.384698] Key type lgssc unregistered [ 6414.613294] LNet: 170698:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6414.624591] LNetError: 170698:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6414.640918] LNet: Removed LNI 192.168.206.51@tcp [ 6415.205252] Key type .llcrypt unregistered [ 6415.210531] Key type ._llcrypt unregistered [ 6424.151735] Key type ._llcrypt registered [ 6424.154027] Key type .llcrypt registered [ 6424.399893] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6424.408453] alg: No test for adler32 (adler32-zlib) [ 6425.421088] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 6425.604900] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 6427.248434] Key type lgssc registered [ 6428.139531] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6465.612066] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6469.569172] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6484.512952] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6495.241537] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 6500.144406] Lustre: Unmounted lustre-client [ 6521.386825] Key type lgssc unregistered [ 6521.546571] LNet: 173757:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6521.550186] LNetError: 173757:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6521.562378] LNet: Removed LNI 192.168.206.51@tcp [ 6521.939821] Key type .llcrypt unregistered [ 6521.941578] Key type ._llcrypt unregistered [ 6529.886780] Key type ._llcrypt registered [ 6529.888481] Key type .llcrypt registered [ 6530.527418] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 23:40:50 (1788752450) [ 6531.556787] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6531.564145] alg: No test for adler32 (adler32-zlib) [ 6532.470901] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 6532.583856] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 6534.184405] Key type lgssc registered [ 6534.781164] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6563.031038] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6565.990220] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6577.848744] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6580.292808] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 6594.077965] Lustre: Unmounted lustre-client [ 6622.369648] Key type lgssc unregistered [ 6622.528707] LNet: 177497:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6622.533468] LNetError: 177497:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6622.546270] LNet: Removed LNI 192.168.206.51@tcp [ 6622.915926] Key type .llcrypt unregistered [ 6622.917547] Key type ._llcrypt unregistered [ 6629.595683] Key type ._llcrypt registered [ 6629.597457] Key type .llcrypt registered [ 6629.811135] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 6629.816807] alg: No test for adler32 (adler32-zlib) [ 6630.716274] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 6630.876857] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 6632.504316] Key type lgssc registered [ 6633.087988] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6659.795640] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6662.824987] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6674.473776] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6675.809527] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 6683.750570] Lustre: Unmounted lustre-client [ 6704.592774] Key type lgssc unregistered [ 6704.747366] LNet: 180548:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6704.757411] LNetError: 180548:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6704.773202] LNet: Removed LNI 192.168.206.51@tcp [ 6705.138285] Key type .llcrypt unregistered [ 6705.140516] Key type ._llcrypt unregistered [ 6714.471685] Key type ._llcrypt registered [ 6714.473178] Key type .llcrypt registered [ 6715.314501] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 23:43:55 (1788752635) [ 6727.167948] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6727.197417] alg: No test for adler32 (adler32-zlib) [ 6728.112561] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 6728.241020] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 6729.856225] Key type lgssc registered [ 6730.591202] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6776.644465] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6779.795896] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6792.021867] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6819.585363] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 23:45:39 (1788752739) [ 6836.940162] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6840.082294] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6851.113800] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6852.392416] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 6858.786064] Lustre: Unmounted lustre-client [ 6868.329177] Key type lgssc unregistered [ 6868.489675] LNet: 187624:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6868.494695] LNetError: 187624:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6868.503993] LNet: Removed LNI 192.168.206.51@tcp [ 6868.923220] Key type .llcrypt unregistered [ 6868.925688] Key type ._llcrypt unregistered [ 6878.067228] Key type ._llcrypt registered [ 6878.069460] Key type .llcrypt registered [ 6878.866280] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 6879.885724] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 23:46:39 (1788752799) [ 6888.855182] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6888.868921] alg: No test for adler32 (adler32-zlib) [ 6889.787570] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 6889.908182] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 6891.520190] Key type lgssc registered [ 6892.140688] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6937.858078] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6940.663658] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6952.196471] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6963.110049] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6964.536778] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 6974.524474] Lustre: Unmounted lustre-client [ 7058.149292] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7060.798062] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7072.728838] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7104.120275] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 23:50:23 (1788753023) [ 7105.088242] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 7106.052373] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 23:50:25 (1788753025) [ 7162.784642] Key type lgssc unregistered [ 7162.917816] LNet: 199020:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7162.922449] LNetError: 199020:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7162.931644] LNet: Removed LNI 192.168.206.51@tcp [ 7163.226917] Key type .llcrypt unregistered [ 7163.229580] Key type ._llcrypt unregistered [ 7169.835565] Key type ._llcrypt registered [ 7169.836923] Key type .llcrypt registered [ 7170.431725] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 23:51:30 (1788753090) [ 7196.350350] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7196.357706] alg: No test for adler32 (adler32-zlib) [ 7197.223335] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 7197.330877] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 7198.920217] Key type lgssc registered [ 7199.369382] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7218.418491] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7220.973749] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7242.278367] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7254.431719] Key type lgssc unregistered [ 7254.549029] LNet: 202739:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7254.552420] LNetError: 202739:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7254.564401] LNet: Removed LNI 192.168.206.51@tcp [ 7254.841167] Key type .llcrypt unregistered [ 7254.842453] Key type ._llcrypt unregistered [ 7261.097062] Key type ._llcrypt registered [ 7261.098375] Key type .llcrypt registered [ 7261.690725] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 23:53:01 (1788753181) [ 7262.771364] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7262.780023] alg: No test for adler32 (adler32-zlib) [ 7263.657575] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 7263.766281] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 7265.361169] Key type lgssc registered [ 7265.848175] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7287.228233] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7289.487360] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7300.296494] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7306.720836] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 7316.964111] Lustre: lustre-MDT0000-mdc-ffff89adc8199000: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7327.202809] Lustre: lustre-MDT0001-mdc-ffff89adc8199000: Connection to lustre-MDT0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7337.376608] Lustre: 203721:0:(client.c:2504:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788753242/real 1788753242] req@00000000eb69ec2f x1875643658748416/t0(0) o400->MGC192.168.206.151@tcp@192.168.206.151@tcp:26/25 lens 224/224 e 0 to 1 dl 1788753258 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 7337.387731] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 7337.397311] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0xa9b6ec0757391fe3 to 0xa9b6ec075739394a [ 7337.403290] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 7358.570457] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7362.020519] LustreError: lustre-MDT0000-mdc-ffff89adc8199000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 7362.048014] Lustre: lustre-MDT0000-mdc-ffff89adc8199000: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 7363.440909] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 4 sec [ 7366.265851] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7368.034768] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 1 sec [ 7369.183819] Lustre: Unmounted lustre-client [ 7388.054714] Key type lgssc unregistered [ 7388.198563] LNet: 207695:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7388.201752] LNetError: 207695:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7388.210656] LNet: Removed LNI 192.168.206.51@tcp [ 7388.530103] Key type .llcrypt unregistered [ 7388.531653] Key type ._llcrypt unregistered [ 7395.607339] Key type ._llcrypt registered [ 7395.608912] Key type .llcrypt registered [ 7396.318330] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 23:55:16 (1788753316) [ 7397.415413] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7397.450224] alg: No test for adler32 (adler32-zlib) [ 7398.355260] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 7398.469743] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 7400.064573] Key type lgssc registered [ 7400.606200] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7427.553806] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7430.218095] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7458.838875] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7461.426512] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7477.911105] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7486.576833] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7530.080935] Key type lgssc unregistered [ 7530.230282] LNet: 212970:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7530.233920] LNetError: 212970:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7530.249871] LNet: Removed LNI 192.168.206.51@tcp [ 7530.559668] Key type .llcrypt unregistered [ 7530.563215] Key type ._llcrypt unregistered [ 7553.862044] Key type ._llcrypt registered [ 7553.864783] Key type .llcrypt registered [ 7554.493573] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 23:57:54 (1788753474) [ 7570.770864] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7570.780448] alg: No test for adler32 (adler32-zlib) [ 7571.685970] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 7571.799503] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 7573.400276] Key type lgssc registered [ 7573.955784] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7610.241569] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7612.707613] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7624.234369] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7648.901634] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 23:59:28 (1788753568) [ 7652.016935] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 23:59:32 (1788753572) [ 7665.901731] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7668.591361] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7678.396614] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7686.117622] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 7693.437581] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 7694.393149] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 7695.095989] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 7695.868535] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 7701.477805] Lustre: lustre-MDT0000-mdc-ffff89adc4e5e800: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7711.719555] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 7711.735700] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0x7526f73efc204e92 to 0x7526f73efc20510f [ 7711.743522] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 7716.623125] Lustre: lustre-MDT0000-mdc-ffff89adc4e5e800: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 7719.094676] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7719.810749] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7721.958944] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 7727.074890] Lustre: lustre-MDT0000-mdc-ffff89adc4e5e800: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 7737.317922] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 7737.328847] Lustre: Evicted from MGS (at 192.168.206.151@tcp) after server handle changed from 0x7526f73efc20510f to 0x7526f73efc20541f [ 7737.334335] Lustre: MGC192.168.206.151@tcp: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 7742.239083] Lustre: lustre-MDT0000-mdc-ffff89adc4e5e800: Connection restored to 192.168.206.151@tcp (at 192.168.206.151@tcp) [ 7745.414528] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7746.264994] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7748.252455] Lustre: Unmounted lustre-client [ 7786.489054] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7788.634639] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7797.307876] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7802.882954] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 7808.593223] Lustre: Unmounted lustre-client [ 7826.840507] Key type lgssc unregistered [ 7826.964640] LNet: 225425:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7826.967326] LNetError: 225425:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7826.981647] LNet: Removed LNI 192.168.206.51@tcp [ 7827.251205] Key type .llcrypt unregistered [ 7827.252665] Key type ._llcrypt unregistered [ 7833.610768] Key type ._llcrypt registered [ 7833.612768] Key type .llcrypt registered [ 7834.228031] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 00:02:34 (1788753754) [ 7835.874142] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7835.881980] alg: No test for adler32 (adler32-zlib) [ 7836.775170] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 7836.883382] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 7838.488327] Key type lgssc registered [ 7839.068461] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7861.103910] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7863.558903] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7872.653460] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7879.145490] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 7886.214230] Lustre: Unmounted lustre-client [ 7921.862178] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7924.125355] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7932.210821] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7937.560075] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 7943.853309] Lustre: Unmounted lustre-client [ 7980.285100] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7982.408141] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7990.211806] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7995.895585] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 7996.414237] Lustre: Unmounted lustre-client [ 8014.706423] Key type lgssc unregistered [ 8014.846790] LNet: 232436:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8014.849618] LNetError: 232436:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8014.859392] LNet: Removed LNI 192.168.206.51@tcp [ 8015.150134] Key type .llcrypt unregistered [ 8015.151748] Key type ._llcrypt unregistered [ 8021.326694] Key type ._llcrypt registered [ 8021.328103] Key type .llcrypt registered [ 8021.933847] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 00:05:41 (1788753941) [ 8023.177940] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8023.190879] alg: No test for adler32 (adler32-zlib) [ 8024.075659] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 8024.189962] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8025.784218] Key type lgssc registered [ 8026.249490] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8044.911754] Key type lgssc unregistered [ 8045.046605] LNet: 234745:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8045.050195] LNetError: 234745:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8045.060311] LNet: Removed LNI 192.168.206.51@tcp [ 8045.366052] Key type .llcrypt unregistered [ 8045.368066] Key type ._llcrypt unregistered [ 8056.476273] Key type ._llcrypt registered [ 8056.478498] Key type .llcrypt registered [ 8056.709690] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8056.750886] alg: No test for adler32 (adler32-zlib) [ 8057.638543] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 8057.757548] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8059.360223] Key type lgssc registered [ 8059.864528] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8095.506413] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8098.030649] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8107.621093] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8131.508091] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [ 8132.252942] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 00:07:32 (1788754052) [ 8145.344086] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8147.600993] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8155.606502] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8165.604528] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8166.868449] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 8172.007707] Lustre: lustre-OST0001-osc-ffff89adc95c1800: Connection to lustre-OST0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8175.166165] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8185.470213] Lustre: Unmounted lustre-client [ 8210.209060] Key type lgssc unregistered [ 8210.347600] LNet: 241825:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8210.351069] LNetError: 241825:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8210.365541] LNet: Removed LNI 192.168.206.51@tcp [ 8210.694731] Key type .llcrypt unregistered [ 8210.696248] Key type ._llcrypt unregistered [ 8222.725244] Key type ._llcrypt registered [ 8222.726690] Key type .llcrypt registered [ 8223.292577] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 00:09:03 (1788754143) [ 8228.977074] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8228.991351] alg: No test for adler32 (adler32-zlib) [ 8229.877448] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 8229.979787] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8231.576179] Key type lgssc registered [ 8232.085963] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8251.740672] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8253.632907] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8265.647197] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 00:09:45 (1788754185) [ 8277.527366] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8279.519931] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8287.085212] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8289.369720] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 8295.921134] Lustre: Unmounted lustre-client [ 8351.980425] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8354.439434] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8388.683981] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8399.357373] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 8399.950440] Lustre: Unmounted lustre-client [ 8426.661883] Key type lgssc unregistered [ 8426.784542] LNet: 249500:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8426.788238] LNetError: 249500:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8426.800321] LNet: Removed LNI 192.168.206.51@tcp [ 8427.079293] Key type .llcrypt unregistered [ 8427.081873] Key type ._llcrypt unregistered [ 8437.980300] Key type ._llcrypt registered [ 8437.982152] Key type .llcrypt registered [ 8438.171591] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8438.177624] alg: No test for adler32 (adler32-zlib) [ 8439.043263] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 8439.137159] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8440.720163] Key type lgssc registered [ 8441.138775] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8473.346696] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8475.284721] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8483.524668] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8513.952977] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [ 8514.586435] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 00:13:54 (1788754434) [ 8527.433342] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8529.765673] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8538.489831] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8546.273130] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 8552.482987] Lustre: Unmounted lustre-client [ 8571.080294] Key type lgssc unregistered [ 8571.214919] LNet: 256105:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8571.218268] LNetError: 256105:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8571.227671] LNet: Removed LNI 192.168.206.51@tcp [ 8571.526137] Key type .llcrypt unregistered [ 8571.529172] Key type ._llcrypt unregistered [ 8578.048226] Key type ._llcrypt registered [ 8578.050119] Key type .llcrypt registered [ 8578.685506] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [ 8579.463871] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 00:14:59 (1788754499) [ 8583.146364] Key type .llcrypt unregistered [ 8583.148136] Key type ._llcrypt unregistered [ 8586.444415] Key type ._llcrypt registered [ 8586.445575] Key type .llcrypt registered [ 8586.647736] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8586.654713] alg: No test for adler32 (adler32-zlib) [ 8587.537806] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 8587.642984] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8589.241522] Key type lgssc registered [ 8589.737617] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8611.306704] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8622.075247] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 8622.799703] Lustre: Unmounted lustre-client [ 8641.122491] Key type lgssc unregistered [ 8641.249992] LNet: 259540:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8641.254267] LNetError: 259540:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8641.264829] LNet: Removed LNI 192.168.206.51@tcp [ 8641.558107] Key type .llcrypt unregistered [ 8641.559207] Key type ._llcrypt unregistered [ 8647.557622] Key type ._llcrypt registered [ 8647.558961] Key type .llcrypt registered [ 8648.136954] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 00:16:08 (1788754568) [ 8649.051629] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8649.077879] alg: No test for adler32 (adler32-zlib) [ 8649.946950] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 8650.056926] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8651.656772] Key type lgssc registered [ 8652.128799] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8714.691348] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8727.262717] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8729.386967] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8730.610366] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 8731.244060] Lustre: Unmounted lustre-client [ 8749.440217] Key type lgssc unregistered [ 8749.573348] LNet: 263064:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8749.579255] LNetError: 263064:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8749.593898] LNet: Removed LNI 192.168.206.51@tcp [ 8749.893444] Key type .llcrypt unregistered [ 8749.895052] Key type ._llcrypt unregistered [ 8756.448596] Key type ._llcrypt registered [ 8756.451783] Key type .llcrypt registered [ 8757.145396] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 00:17:57 (1788754677) [ 8758.253722] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8758.309244] alg: No test for adler32 (adler32-zlib) [ 8759.234799] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 8759.356707] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8760.968424] Key type lgssc registered [ 8761.475448] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8783.951870] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8786.513882] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8796.143467] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8802.791577] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 8807.906892] Lustre: lustre-MDT0000-mdc-ffff89adc95ac000: Connection to lustre-MDT0000 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8810.618113] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8810.634421] LustreError: 266205:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [ 8810.799955] LustreError: MGC192.168.206.151@tcp: Connection to MGS (at 192.168.206.151@tcp) was lost; in progress operations using this service will fail [ 8810.828034] Lustre: Unmounted lustre-client [ 8823.019383] Key type lgssc unregistered [ 8823.158841] LNet: 266617:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8823.162369] LNetError: 266617:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8823.172939] LNet: Removed LNI 192.168.206.51@tcp [ 8823.446818] Key type .llcrypt unregistered [ 8823.448259] Key type ._llcrypt unregistered [ 8829.848344] Key type ._llcrypt registered [ 8829.849353] Key type .llcrypt registered [ 8830.437496] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 00:19:10 (1788754750) [ 8831.281196] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8831.292706] alg: No test for adler32 (adler32-zlib) [ 8832.170346] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 8832.269944] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8833.864215] Key type lgssc registered [ 8834.373464] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8857.283348] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8859.571590] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8868.054868] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8875.499751] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 8883.438488] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 8883.894109] Lustre: Unmounted lustre-client [ 8895.741579] Key type lgssc unregistered [ 8895.889098] LNet: 270181:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8895.893216] LNetError: 270181:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8895.902848] LNet: Removed LNI 192.168.206.51@tcp [ 8896.193092] Key type .llcrypt unregistered [ 8896.194456] Key type ._llcrypt unregistered [ 8902.274450] Key type ._llcrypt registered [ 8902.275969] Key type .llcrypt registered [ 8902.865731] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 00:20:22 (1788754822) [ 8910.997844] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8911.017820] alg: No test for adler32 (adler32-zlib) [ 8911.940984] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 8912.057367] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 8913.664216] Key type lgssc registered [ 8914.239423] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8964.874903] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8966.123149] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 8988.650202] Lustre: lustre-MDT0001-mdc-ffff89add0aa5800: Connection to lustre-MDT0001 (at 192.168.206.151@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 8992.924535] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 9003.200161] Lustre: Unmounted lustre-client [ 9021.378876] Key type lgssc unregistered [ 9021.523739] LNet: 275957:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9021.528227] LNetError: 275957:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9021.539066] LNet: Removed LNI 192.168.206.51@tcp [ 9021.850730] Key type .llcrypt unregistered [ 9021.852425] Key type ._llcrypt unregistered [ 9028.141904] Key type ._llcrypt registered [ 9028.143380] Key type .llcrypt registered [ 9028.783659] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 00:22:28 (1788754948) [ 9029.567241] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [ 9030.316329] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 00:22:30 (1788754950) [ 9031.046138] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [ 9031.875605] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 00:22:31 (1788754951) [ 9032.614706] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [ 9033.399390] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 00:22:33 (1788754953) [ 9034.149775] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [ 9034.931927] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 00:22:34 (1788754954) [ 9035.665825] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [ 9036.396094] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 00:22:36 (1788754956) [ 9040.361600] Key type .llcrypt unregistered [ 9040.363229] Key type ._llcrypt unregistered [ 9043.040095] Key type ._llcrypt registered [ 9043.043044] Key type .llcrypt registered [ 9043.217084] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9043.230690] alg: No test for adler32 (adler32-zlib) [ 9044.111514] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 9044.224960] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 9045.824224] Key type lgssc registered [ 9046.270244] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9080.234166] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9082.549386] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9092.665802] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9093.929958] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 9094.721771] Lustre: Unmounted lustre-client [ 9120.259100] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 00:24:00 (1788755040) [ 9134.503791] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9136.941449] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9158.363757] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9174.005087] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [ 9174.407694] Lustre: Unmounted lustre-client [ 9200.951766] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 00:25:21 (1788755121) [ 9217.312616] LNet: 1 local NIs in recovery (showing 1): 192.168.206.51@tcp [ 9795.701844] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9798.117446] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9819.097544] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9878.739865] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 00:36:38 (1788755798) [ 9883.002288] Key type lgssc unregistered [ 9883.132870] LNet: 289427:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9883.136401] LNetError: 289427:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9883.146746] LNet: Removed LNI 192.168.206.51@tcp [ 9883.419409] Key type .llcrypt unregistered [ 9883.420389] Key type ._llcrypt unregistered [ 9948.201098] Key type ._llcrypt registered [ 9948.202545] Key type .llcrypt registered [ 9948.344202] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9948.352316] alg: No test for adler32 (adler32-zlib) [ 9949.249424] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [ 9949.359642] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [ 9950.960344] Key type lgssc registered [ 9951.487317] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9988.736997] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9990.741133] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9999.168430] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10013.448806] Key type lgssc unregistered [10013.579678] LNet: 293093:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10013.582826] LNetError: 293093:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10013.590855] LNet: Removed LNI 192.168.206.51@tcp [10013.885930] Key type .llcrypt unregistered [10013.887214] Key type ._llcrypt unregistered [10043.242203] Key type ._llcrypt registered [10043.243390] Key type .llcrypt registered [10043.796543] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 00:39:23 (1788755963) [10052.930565] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10052.943199] alg: No test for adler32 (adler32-zlib) [10053.833994] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [10053.935672] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [10055.528218] Key type lgssc registered [10055.991152] Lustre: Echo OBD driver; http://www.lustre.org/ [10077.691089] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 00:39:57 (1788755997) [10083.082348] Key type lgssc unregistered [10083.230952] LNet: 296635:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10083.236175] LNetError: 296635:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10083.251360] LNet: Removed LNI 192.168.206.51@tcp [10083.637739] Key type .llcrypt unregistered [10083.642785] Key type ._llcrypt unregistered [10088.399327] Key type ._llcrypt registered [10088.400758] Key type .llcrypt registered [10088.605393] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10088.613017] alg: No test for adler32 (adler32-zlib) [10089.504685] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [10089.614656] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [10091.224277] Key type lgssc registered [10091.715740] Lustre: Echo OBD driver; http://www.lustre.org/ [10118.546891] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10120.905275] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10131.233656] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10244.701833] LNet: Added LNI 192.168.206.51@tcp50 [8/256/0/180] [10245.707903] LNet: Removed LNI 192.168.206.51@tcp [10247.230674] Lustre: 300993:0:(ldlm_lib.c:562:client_obd_setup()) lustre-MDT0000-mdc-ffff89add0feb000: config has no valid NIDs, force dynamic NIDs [10248.306431] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [10248.372738] Lustre: Unmounted lustre-client [10249.456597] Key type lgssc unregistered [10249.614333] LNet: 301251:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10249.617801] LNetError: 301251:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10249.628705] LNet: Removed LNI 192.168.206.51@tcp50 [10249.872500] Key type .llcrypt unregistered [10249.873923] Key type ._llcrypt unregistered [10260.931925] Key type ._llcrypt registered [10260.933394] Key type .llcrypt registered [10261.156210] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10261.173195] alg: No test for adler32 (adler32-zlib) [10262.087217] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [10262.195884] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [10263.800332] Key type lgssc registered [10264.286449] Lustre: Echo OBD driver; http://www.lustre.org/ [10293.405789] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10295.465768] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10298.154627] LNet: Added LNI 192.168.206.51@tcp50 [8/256/0/180] [10298.469607] LNet: Removed LNI 192.168.206.51@tcp [10299.573269] Lustre: 303930:0:(ldlm_lib.c:562:client_obd_setup()) lustre-MDT0000-mdc-ffff89adc6115800: config has no valid NIDs, force dynamic NIDs [10300.635360] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [10300.890493] Lustre: Unmounted lustre-client [10321.304658] Key type lgssc unregistered [10321.475486] LNet: 304799:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10321.478823] LNetError: 304799:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10321.486849] LNet: Removed LNI 192.168.206.51@tcp50 [10321.788483] Key type .llcrypt unregistered [10321.790059] Key type ._llcrypt unregistered [10326.195618] Key type ._llcrypt registered [10326.196807] Key type .llcrypt registered [10326.775931] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 00:44:06 (1788756246) [10334.045143] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10334.057288] alg: No test for adler32 (adler32-zlib) [10334.964992] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [10335.095490] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [10336.712296] Key type lgssc registered [10337.346951] Lustre: Echo OBD driver; http://www.lustre.org/ [10379.089347] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10381.618433] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10391.886274] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10413.647183] Key type lgssc unregistered [10413.808621] LNet: 309530:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10413.811759] LNetError: 309530:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10413.820924] LNet: Removed LNI 192.168.206.51@tcp [10414.185531] Key type .llcrypt unregistered [10414.188338] Key type ._llcrypt unregistered [10418.852031] Key type ._llcrypt registered [10418.854086] Key type .llcrypt registered [10419.537965] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 00:45:39 (1788756339) [10420.531976] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10420.551368] alg: No test for adler32 (adler32-zlib) [10421.466517] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [10421.592426] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [10423.208205] Key type lgssc registered [10423.861665] Lustre: Echo OBD driver; http://www.lustre.org/ [10446.177687] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10448.309726] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10456.989395] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10463.733609] Lustre: Mounted lustre-client - version 2.17.58_39_g34d8757 [10493.601319] Lustre: Mounted fs15246-client - version 2.17.58_39_g34d8757 [10499.615639] Lustre: Unmounted fs15246-client [10515.158190] Lustre: Unmounted lustre-client [10534.071823] Key type lgssc unregistered [10534.219526] LNet: 314365:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10534.225652] LNetError: 314365:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10534.244086] LNet: Removed LNI 192.168.206.51@tcp [10534.586526] Key type .llcrypt unregistered [10534.588691] Key type ._llcrypt unregistered [10539.568289] Key type ._llcrypt registered [10539.569378] Key type .llcrypt registered [10540.246608] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 00:47:40 (1788756460) [10541.051093] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10541.060588] alg: No test for adler32 (adler32-zlib) [10541.962637] Lustre: Lustre: Build Version: 2.17.58_39_g34d8757 [10542.091375] LNet: Added LNI 192.168.206.51@tcp [8/256/0/180] [10543.696615] Key type lgssc registered [10544.268512] Lustre: Echo OBD driver; http://www.lustre.org/ [10605.159379] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10607.529063] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10618.073698] Lustre: DEBUG MARKER: oleg651-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10669.823533] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 10347 sec ========= 00:49:49 (1788756589) [10670.651619] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 00:49:50 (1788756590) === [10672.417162] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 00:49:52 (1788756592) === [10687.451939] Key type lgssc unregistered [10687.608572] LNet: 323594:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10687.613182] LNetError: 323594:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10687.627487] LNet: Removed LNI 192.168.206.51@tcp [10688.024397] Key type .llcrypt unregistered [10688.027745] Key type ._llcrypt unregistered