[ 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 452939971 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 2608MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001016] APIC: Switch to symmetric I/O mode setup [ 0.002295] x2apic enabled [ 0.003013] Switched APIC routing to physical x2apic. [ 0.004011] kvm-guest: setup PV IPIs [ 0.007745] ..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.008044] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009015] pid_max: default: 32768 minimum: 301 [ 0.011149] LSM: Security Framework initializing [ 0.013053] Yama: becoming mindful. [ 0.014045] SELinux: Initializing. [ 0.015075] *** VALIDATE selinux *** [ 0.024463] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.028000] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028193] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029120] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030126] *** VALIDATE tmpfs *** [ 0.031457] *** VALIDATE proc *** [ 0.033026] *** VALIDATE cgroup *** [ 0.034000] *** VALIDATE cgroup2 *** [ 0.035160] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.036165] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.037007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.038028] Spectre V2 : User space: Vulnerable [ 0.039009] Speculative Store Bypass: Vulnerable [ 0.041938] debug: unmapping init [mem 0xffffffffa1459000-0xffffffffa1460fff] [ 0.043169] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044585] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045024] ... version: 2 [ 0.046011] ... bit width: 48 [ 0.047012] ... generic registers: 4 [ 0.048016] ... value mask: 0000ffffffffffff [ 0.049015] ... max period: 00007fffffffffff [ 0.050015] ... fixed-purpose events: 3 [ 0.051019] ... event mask: 000000070000000f [ 0.052392] rcu: Hierarchical SRCU implementation. [ 0.054693] smp: Bringing up secondary CPUs ... [ 0.055644] x86: Booting SMP configuration: [ 0.056024] .... node #0, CPUs: #1 #2 #3 [ 0.059554] smp: Brought up 1 node, 4 CPUs [ 0.061016] smpboot: Max logical packages: 1 [ 0.062020] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.141024] node 0 deferred pages initialised in 76ms [ 0.146259] devtmpfs: initialized [ 0.147384] x86/mm: Memory block size: 128MB [ 0.149746] gcov: version magic: 0x41383552 [ 0.151280] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.152085] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.153316] pinctrl core: initialized pinctrl subsystem [ 0.154204] [ 0.154690] ************************************************************* [ 0.155015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.156018] ** ** [ 0.157020] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.158033] ** ** [ 0.159016] ** This means that this kernel is built to expose internal ** [ 0.160032] ** IOMMU data structures, which may compromise security on ** [ 0.161018] ** your system. ** [ 0.162015] ** ** [ 0.163018] ** If you see this message and you are not debugging the ** [ 0.164017] ** kernel, report this immediately to your vendor! ** [ 0.165014] ** ** [ 0.166018] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.167019] ************************************************************* [ 0.168766] NET: Registered protocol family 16 [ 0.169415] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.170077] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.171079] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.172655] cpuidle: using governor menu [ 0.176104] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.179670] PCI: Using configuration type 1 for base access [ 0.183134] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.194176] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.195043] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.197031] cryptd: max_cpu_qlen set to 1000 [ 0.199021] ACPI: Added _OSI(Module Device) [ 0.200014] ACPI: Added _OSI(Processor Device) [ 0.201019] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.202020] ACPI: Added _OSI(Processor Aggregator Device) [ 0.206179] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.210766] ACPI: Interpreter enabled [ 0.211071] ACPI: PM: (supports S0 S3 S4 S5) [ 0.212014] ACPI: Using IOAPIC for interrupt routing [ 0.213360] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.216308] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.227612] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.230048] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.233022] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.237081] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.241511] acpiphp: Slot [2] registered [ 0.244204] acpiphp: Slot [5] registered [ 0.245179] acpiphp: Slot [6] registered [ 0.247099] acpiphp: Slot [3] registered [ 0.248077] acpiphp: Slot [4] registered [ 0.249084] acpiphp: Slot [7] registered [ 0.251070] acpiphp: Slot [8] registered [ 0.252090] acpiphp: Slot [9] registered [ 0.254108] acpiphp: Slot [10] registered [ 0.256167] acpiphp: Slot [11] registered [ 0.258111] acpiphp: Slot [12] registered [ 0.259098] acpiphp: Slot [13] registered [ 0.261105] acpiphp: Slot [14] registered [ 0.263133] acpiphp: Slot [15] registered [ 0.265108] acpiphp: Slot [16] registered [ 0.266131] acpiphp: Slot [17] registered [ 0.267164] acpiphp: Slot [18] registered [ 0.268102] acpiphp: Slot [19] registered [ 0.270123] acpiphp: Slot [20] registered [ 0.271110] acpiphp: Slot [21] registered [ 0.273113] acpiphp: Slot [22] registered [ 0.274157] acpiphp: Slot [23] registered [ 0.276170] acpiphp: Slot [24] registered [ 0.278129] acpiphp: Slot [25] registered [ 0.280128] acpiphp: Slot [26] registered [ 0.282118] acpiphp: Slot [27] registered [ 0.284115] acpiphp: Slot [28] registered [ 0.285116] acpiphp: Slot [29] registered [ 0.287103] acpiphp: Slot [30] registered [ 0.288126] acpiphp: Slot [31] registered [ 0.290091] PCI host bridge to bus 0000:00 [ 0.291023] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.294024] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.297027] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.300024] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.302023] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.305029] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.308145] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.311151] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.315211] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.322641] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.327054] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.330020] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.334026] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.337022] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.340711] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.342901] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.346051] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.350026] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.355017] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.366017] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.371594] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.377528] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.383020] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.389000] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.409012] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.417533] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.426018] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.439018] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.456019] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.471713] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.475445] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.477490] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.480369] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.482183] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.485126] iommu: Default domain type: Passthrough [ 0.486347] SCSI subsystem initialized [ 0.487000] ACPI: bus type USB registered [ 0.489112] usbcore: registered new interface driver usbfs [ 0.491097] usbcore: registered new interface driver hub [ 0.493096] usbcore: registered new device driver usb [ 0.495195] pps_core: LinuxPPS API ver. 1 registered [ 0.496026] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.499079] PTP clock support registered [ 0.503078] EDAC MC: Ver: 3.0.0 [ 0.504443] PCI: Using ACPI for IRQ routing [ 0.505812] NetLabel: Initializing [ 0.506017] NetLabel: domain hash size = 128 [ 0.507014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.508102] NetLabel: unlabeled traffic allowed by default [ 0.510243] vgaarb: loaded [ 0.511288] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.513015] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.520005] clocksource: Switched to clocksource kvm-clock [ 0.619141] VFS: Disk quotas dquot_6.6.0 [ 0.620770] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.623449] *** VALIDATE ramfs *** [ 0.624845] *** VALIDATE hugetlbfs *** [ 0.626338] pnp: PnP ACPI init [ 0.628576] pnp: PnP ACPI: found 6 devices [ 0.650786] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.653251] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.654885] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.656469] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.658350] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.660080] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.662213] NET: Registered protocol family 2 [ 0.664472] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.669349] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.676134] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.684535] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.691311] TCP: Hash tables configured (established 65536 bind 65536) [ 0.695200] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.697878] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.700412] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.703291] NET: Registered protocol family 1 [ 0.705715] RPC: Registered named UNIX socket transport module. [ 0.707590] RPC: Registered udp transport module. [ 0.709238] RPC: Registered tcp transport module. [ 0.710627] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.712346] NET: Registered protocol family 44 [ 0.713713] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.715663] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.720104] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.723365] PCI: CLS 0 bytes, default 64 [ 0.725933] Unpacking initramfs... [ 3.740754] debug: unmapping init [mem 0xffff8e05bcc64000-0xffff8e05bffcffff] [ 3.759206] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 3.772176] software IO TLB: mapped [mem 0x00000000b8c64000-0x00000000bcc64000] (64MB) [ 3.791857] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 5.934757] Initialise system trusted keyrings [ 5.948818] Key type blacklist registered [ 5.954495] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 5.990743] zbud: loaded [ 6.014091] *** VALIDATE nfs *** [ 6.022896] *** VALIDATE nfs4 *** [ 6.027699] pstore: using deflate compression [ 6.050843] Platform Keyring initialized [ 6.083023] hrtimer: interrupt took 3024257 ns [ 6.465731] NET: Registered protocol family 38 [ 6.474544] Key type asymmetric registered [ 6.479070] Asymmetric key parser 'x509' registered [ 6.482836] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 6.488167] io scheduler mq-deadline registered [ 6.492018] io scheduler kyber registered [ 6.496959] io scheduler bfq registered [ 6.500158] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 6.503550] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 6.508488] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 6.517501] ACPI: Power Button [PWRF] [ 6.532824] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 6.542320] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 6.561745] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 6.605292] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 6.651859] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 6.662962] Non-volatile memory driver v1.3 [ 6.666365] Linux agpgart interface v0.103 [ 6.765707] virtio_blk virtio1: [vda] 145808 512-byte logical blocks (74.7 MB/71.2 MiB) [ 6.791946] vda: detected capacity change from 0 to 74653696 [ 6.871581] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 6.888864] vdb: detected capacity change from 0 to 1073741824 [ 6.918239] libphy: Fixed MDIO Bus: probed [ 6.955886] usbcore: registered new interface driver usbserial_generic [ 6.961425] usbserial: USB Serial support registered for generic [ 6.978458] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 7.014122] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 7.023884] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 7.033040] mousedev: PS/2 mouse device common for all mice [ 7.040958] rtc_cmos 00:05: RTC can wake from S4 [ 7.051324] rtc_cmos 00:05: registered as rtc0 [ 7.051433] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 7.058528] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 7.058591] intel_pstate: CPU model not supported [ 7.069519] hid: raw HID events driver (C) Jiri Kosina [ 7.094813] usbcore: registered new interface driver usbhid [ 7.098870] usbhid: USB HID core driver [ 7.100176] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 7.102492] drop_monitor: Initializing network drop monitor service [ 7.102750] Initializing XFRM netlink socket [ 7.103204] NET: Registered protocol family 10 [ 7.108066] Segment Routing with IPv6 [ 7.122034] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 7.126352] NET: Registered protocol family 17 [ 7.137631] mpls_gso: MPLS GSO support [ 7.145507] RAS: Correctable Errors collector initialized. [ 7.152715] AVX version of gcm_enc/dec engaged. [ 7.155249] AES CTR mode by8 optimization enabled [ 7.317916] sched_clock: Marking stable (7317826825, 0)->(8288457495, -970630670) [ 7.328107] registered taskstats version 1 [ 7.331406] Loading compiled-in X.509 certificates [ 7.334439] zswap: loaded using pool lzo/zbud [ 7.385309] Key type big_key registered [ 7.409411] Key type encrypted registered [ 7.411496] ima: No TPM chip found, activating TPM-bypass! [ 7.415731] ima: Allocated hash algorithm: sha1 [ 7.422505] ima: No architecture policies found [ 7.425573] evm: Initialising EVM extended attributes: [ 7.429188] evm: security.selinux [ 7.436972] evm: security.ima [ 7.439271] evm: security.capability [ 7.441577] evm: HMAC attrs: 0x1 [ 7.444681] rtc_cmos 00:05: setting system clock to 2026-07-13 12:43:14 UTC (1783946594) [ 7.455365] debug: unmapping init [mem 0xffffffffa2403000-0xffffffffa25fffff] [ 7.471235] debug: unmapping init [mem 0xffffffffa1182000-0xffffffffa1458fff] [ 7.488163] Write protecting the kernel read-only data: 28672k [ 7.492637] debug: unmapping init [mem 0xffffffff9f803000-0xffffffff9f9fffff] [ 7.502538] debug: unmapping init [mem 0xffffffffa0114000-0xffffffffa01fffff] [ 7.621364] 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) [ 7.637663] systemd[1]: Detected virtualization kvm. [ 7.640992] systemd[1]: Detected architecture x86-64. [ 7.647594] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 7.716250] systemd[1]: No hostname configured. [ 7.721640] systemd[1]: Set hostname to . [ 7.725686] random: systemd: uninitialized urandom read (16 bytes read) [ 7.730687] systemd[1]: Initializing machine ID from random generator. [ 7.857432] random: ln: uninitialized urandom read (6 bytes read) [ 8.147779] random: systemd: uninitialized urandom read (16 bytes read) [ 8.155441] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 8.183686] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 8.199922] systemd[1]: Reached target Timers. [ OK ] Reached target Timers. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Slices. [ OK ] Reached target Swap. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Initrd Root Device. [ OK ] Listening on Journal Socket. Starting Create list of required st…ce nodes for the current kernel... Starting Setup Virtual Console... [ OK ] Reached target Sockets. Starting Journal Service... Starting Apply Kernel Variables... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Reached target Local Encrypted Volumes. [ OK ] Started Memstrack Anylazing Service. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 10.177132] device-mapper: uevent: version 1.0.3 [ 10.185646] 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. Starting dracut initqueue hook... [ 12.622349] virtio_net virtio0 ens2: renamed from eth0 [ 12.861888] scsi host0: ata_piix [ 12.924724] scsi host1: ata_piix [ 12.927743] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 12.936682] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 17.974170] random: crng init done [ 17.978366] random: 7 urandom warning(s) missed due to ratelimiting [ 20.433164] dracut-initqueue[585]: RTNETLINK answers: File exists Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 21.968195] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Started Cleaning Up and Shutting Down Daemons. [ 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... [ 24.552425] printk: systemd: 26 output lines suppressed due to ratelimiting [ 25.432614] SELinux: Disabled at runtime. [ 25.571780] 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) [ 25.587918] systemd[1]: Detected virtualization kvm. [ 25.590180] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 27.303748] systemd[1]: initrd-switch-root.service: Succeeded. [ 27.319631] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 27.345747] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 27.351332] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 27.360734] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 27.381098] systemd[1]: Starting Journal Service... Starting Journal Service... [ 27.403299] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-getty.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. [ OK ] Started Forward Password Requests to Wall Directory Watch. Activating swap /dev/disk/by-label/SWAP... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Listening on udev Kernel Socket. [ 27.591400] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. [ OK ] Reached target rpc_pipefs.target. [ OK ] Created slice system-sshd\x2dkeygen.slice. Mounting Kernel Debug File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. [ OK ] Listening on RPCbind Server Activation Socket. Mounting Huge Pages File System... Starting udev Coldplug all Devices... Mounting POSIX Message Queue File System... [ OK ] Listening on initctl Compatibility Named Pipe. Starting Remount Root and Kernel File Systems... [ OK ] Reached target RPC Port Mapper. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. Starting Apply Kernel Variables... [ OK ] Reached target Paths. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Kernel Debug File System. [ OK ] Mounted Huge Pages File System. [ 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... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started udev Coldplug all Devices. [ OK ] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [ OK ] Reached target Local File Systems (Pre). Mounting /mnt... Mounting /home/green/git/lustre-release... [ OK ] Mounted /mnt. [ 29.065123] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 30.051218] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 30.146030] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 30.477714] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 30.558321] EDAC sbridge: Ver: 1.1.2 [ 33.716141] Key type dns_resolver registered [ 34.482703] NFS: Registering the id_resolver key type [ 34.486695] Key type id_resolver registered [ 34.493617] Key type id_legacy registered [* ] A start job is running for Configur…-only root support (7s / no limit) [ OK ] Started Configure read-only root support. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. Starting Rebuild Dynamic Linker Cache... Starting Mark the need to relabel after reboot... 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 ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. Starting Restore /run/initramfs on shutdown... [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Login Service... [ 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 Login Service. Starting Hostname Service... [ OK ] Started OpenSSH server daemon. [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started Permit User Sessions. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Command Scheduler. [ 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 oleg448-client login: [ 109.332606] libcfs: loading out-of-tree module taints kernel. [ 109.477411] Key type ._llcrypt registered [ 109.478942] Key type .llcrypt registered [ 110.007178] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 110.024919] alg: No test for adler32 (adler32-zlib) [ 111.834606] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 112.726858] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 114.455240] Key type lgssc registered [ 116.559575] Lustre: Echo OBD driver; http://www.lustre.org/ [ 287.638797] Lustre: Mounted lustre-client [ 290.773652] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 303.389867] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing check_logdir /tmp/testlogs/ [ 309.286953] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing yml_node [ 313.321893] Lustre: lustre-OST0000-osc-ffff8e06030b4800: disconnect after 24s idle [ 315.045957] Lustre: DEBUG MARKER: Client: 2.17.54.162 [ 318.152368] Lustre: DEBUG MARKER: MDS: 2.17.54.162 [ 322.676142] Lustre: DEBUG MARKER: OSS: 2.17.54.162 [ 324.899334] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Mon Jul 13 08:48:30 EDT 2026 [ 348.717724] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 350.831198] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 354.022936] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 364.334382] Lustre: Unmounted lustre-client [ 486.131834] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 493.003393] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 523.805843] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 566.044195] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 08:52:31 (1783947151) [ 568.525142] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 570.388482] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 08:52:36 (1783947156) [ 607.185886] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 613.746502] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 638.295493] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 638.948688] Lustre: Mounted lustre-client [ 646.983307] Lustre: Unmounted lustre-client [ 675.394864] Key type lgssc unregistered [ 675.699860] LNet: 15030:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 675.726895] LNetError: 15030:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 675.743259] LNet: Removed LNI 192.168.204.48@tcp [ 676.564258] Key type .llcrypt unregistered [ 676.569985] Key type ._llcrypt unregistered [ 692.046387] Key type ._llcrypt registered [ 692.050435] Key type .llcrypt registered [ 693.499781] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 08:54:38 (1783947278) [ 695.409667] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 695.437304] alg: No test for adler32 (adler32-zlib) [ 696.550487] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 696.770128] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 698.456643] Key type lgssc registered [ 699.928970] Lustre: Echo OBD driver; http://www.lustre.org/ [ 773.813363] Lustre: Mounted lustre-client [ 861.356197] Lustre: Unmounted lustre-client [ 890.438493] Key type lgssc unregistered [ 890.756139] LNet: 18893:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 890.774162] LNetError: 18893:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 890.801307] LNet: Removed LNI 192.168.204.48@tcp [ 891.708299] Key type .llcrypt unregistered [ 891.714131] Key type ._llcrypt unregistered [ 905.006447] Key type ._llcrypt registered [ 905.014548] Key type .llcrypt registered [ 906.744488] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 08:58:11 (1783947491) [ 909.737365] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 909.807658] alg: No test for adler32 (adler32-zlib) [ 910.913403] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 911.214930] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 912.991619] Key type lgssc registered [ 914.814170] Lustre: Echo OBD driver; http://www.lustre.org/ [ 966.293520] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 971.958763] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 992.961182] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 995.669828] Lustre: Mounted lustre-client [ 1009.237967] Lustre: Unmounted lustre-client [ 1037.504325] Key type lgssc unregistered [ 1037.758640] LNet: 22500:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1037.765486] LNetError: 22500:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1037.791392] LNet: Removed LNI 192.168.204.48@tcp [ 1038.453659] Key type .llcrypt unregistered [ 1038.456502] Key type ._llcrypt unregistered [ 1049.343292] Key type ._llcrypt registered [ 1049.346938] Key type .llcrypt registered [ 1051.155463] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 09:00:36 (1783947636) [ 1054.119205] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1054.166523] alg: No test for adler32 (adler32-zlib) [ 1055.399516] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1055.739564] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1057.471814] Key type lgssc registered [ 1058.772256] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1111.422911] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1117.461978] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1137.449735] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1139.053279] Lustre: Mounted lustre-client [ 1144.853477] Lustre: Unmounted lustre-client [ 1173.496372] Key type lgssc unregistered [ 1173.823373] LNet: 25705:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1173.833287] LNetError: 25705:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1173.854562] LNet: Removed LNI 192.168.204.48@tcp [ 1174.605686] Key type .llcrypt unregistered [ 1174.607692] Key type ._llcrypt unregistered [ 1189.753608] Key type ._llcrypt registered [ 1189.767497] Key type .llcrypt registered [ 1191.233909] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 09:02:56 (1783947776) [ 1193.617520] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1193.640724] alg: No test for adler32 (adler32-zlib) [ 1194.906631] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1195.325351] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1196.999185] Key type lgssc registered [ 1198.377753] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1251.557814] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1257.282641] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1277.244528] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1279.993832] Lustre: Mounted lustre-client [ 1290.224801] Lustre: lustre-MDT0000-mdc-ffff8e0608a23000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1300.467825] Lustre: lustre-MDT0001-mdc-ffff8e0608a23000: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1304.494644] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1311.711643] Lustre: 26666:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783947882/real 1783947882] req@00000000145d4bf0 x1870604829464704/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1783947898 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1311.755792] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 1314.922479] Lustre: Unmounted lustre-client [ 1343.709904] Key type lgssc unregistered [ 1344.072041] LNet: 29365:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1344.079847] LNetError: 29365:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1345.130628] LNet: Removed LNI 192.168.204.48@tcp [ 1346.044485] Key type .llcrypt unregistered [ 1346.047422] Key type ._llcrypt unregistered [ 1362.764826] Key type ._llcrypt registered [ 1362.767586] Key type .llcrypt registered [ 1364.468691] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 09:05:49 (1783947949) [ 1367.034386] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1367.090316] alg: No test for adler32 (adler32-zlib) [ 1368.206222] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1368.564485] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1370.294931] Key type lgssc registered [ 1371.929712] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1425.548664] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1430.430346] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1453.454456] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1456.499324] Lustre: Mounted lustre-client [ 1461.750919] Lustre: lustre-OST0000-osc-ffff8e0604b1e000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1469.176533] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1479.522473] Lustre: Unmounted lustre-client [ 1514.495105] Key type lgssc unregistered [ 1514.770783] LNet: 32989:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1514.787100] LNetError: 32989:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1515.815952] LNet: Removed LNI 192.168.204.48@tcp [ 1516.868790] Key type .llcrypt unregistered [ 1516.873318] Key type ._llcrypt unregistered [ 1532.399643] Key type ._llcrypt registered [ 1532.406239] Key type .llcrypt registered [ 1533.843831] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 09:08:39 (1783948119) [ 1536.509941] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1536.523410] alg: No test for adler32 (adler32-zlib) [ 1537.600884] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1537.844499] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1539.543668] Key type lgssc registered [ 1540.682706] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1589.362798] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1594.632337] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1613.027170] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1615.649138] Lustre: Mounted lustre-client [ 1619.834448] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1623.274516] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1635.128176] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-07-13 9h10m20s [ 1637.144349] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1641.447900] Lustre: lustre-MDT0000-mdc-ffff8e0603efc000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1647.600585] LustreError: 36777:0:(lmv_obd.c:1468:lmv_statfs()) lustre-MDT0000-mdc-ffff8e0603efc000: can't stat MDS #0: rc = -19 [ 1648.964924] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1658.854717] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 1658.879144] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0xcbff89cae5fec8be to 0xcbff89cae5fecb81 [ 1658.887124] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 1659.954436] LustreError: lustre-MDT0000-mdc-ffff8e0603efc000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1659.982958] Lustre: lustre-MDT0000-mdc-ffff8e0603efc000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 1664.443705] Lustre: DEBUG MARKER: Wait for df (36777) ... [ 1666.264760] Lustre: DEBUG MARKER: done [ 1668.705307] Lustre: Unmounted lustre-client [ 1704.059217] Key type lgssc unregistered [ 1704.361070] LNet: 37795:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1704.373079] LNetError: 37795:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1704.413656] LNet: Removed LNI 192.168.204.48@tcp [ 1705.196128] Key type .llcrypt unregistered [ 1705.199861] Key type ._llcrypt unregistered [ 1734.806945] Key type ._llcrypt registered [ 1734.810353] Key type .llcrypt registered [ 1736.162705] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 09:12:01 (1783948321) [ 1739.052913] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1739.104450] alg: No test for adler32 (adler32-zlib) [ 1740.145849] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1740.467522] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1742.175204] Key type lgssc registered [ 1743.341918] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1794.213767] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1799.468297] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1818.985628] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1821.613103] Lustre: Mounted lustre-client [ 1825.533016] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-07-13 9h13m31s [ 1826.867041] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1833.067145] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1835.375966] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1855.967253] Lustre: 41942:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783948422/real 1783948422] req@00000000a61ee8ae x1870605400938624/t0(0) o101->lustre-MDT0000-mdc-ffff8e0608029000@192.168.204.148@tcp:12/10 lens 576/1152 e 0 to 1 dl 1783948442 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1855.992818] Lustre: lustre-MDT0000-mdc-ffff8e0608029000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1856.019337] Lustre: lustre-MDT0000-mdc-ffff8e0608029000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 1877.257226] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1880.506363] Lustre: DEBUG MARKER: done [ 1884.361022] Lustre: Unmounted lustre-client [ 1911.322192] Key type lgssc unregistered [ 1911.662420] LNet: 42818:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1911.675542] LNetError: 42818:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1911.713276] LNet: Removed LNI 192.168.204.48@tcp [ 1912.509892] Key type .llcrypt unregistered [ 1912.514803] Key type ._llcrypt unregistered [ 1942.136772] Key type ._llcrypt registered [ 1942.139392] Key type .llcrypt registered [ 1943.595584] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 09:15:28 (1783948528) [ 1945.713856] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1947.652635] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 09:15:33 (1783948533) [ 1951.729268] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1951.792047] alg: No test for adler32 (adler32-zlib) [ 1953.047933] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 1953.386818] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 1955.153898] Key type lgssc registered [ 1956.812154] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1985.042252] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 09:16:10 (1783948570) [ 2020.303028] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2026.888298] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2048.687294] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2050.515170] Lustre: Mounted lustre-client [ 2054.122806] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2057.816757] Lustre: Unmounted lustre-client [ 2073.789983] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2119.838603] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2126.007290] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2126.800853] Lustre: Mounted lustre-client [ 2130.609815] Lustre: Unmounted lustre-client [ 2189.166650] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2195.038618] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2195.628304] Lustre: Mounted lustre-client [ 2200.081808] Lustre: Unmounted lustre-client [ 2231.235313] Lustre: DEBUG MARKER: files compared the same [ 2253.805346] Key type lgssc unregistered [ 2254.141948] LNet: 50443:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2254.151854] LNetError: 50443:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2254.173492] LNet: Removed LNI 192.168.204.48@tcp [ 2254.984476] Key type .llcrypt unregistered [ 2254.993326] Key type ._llcrypt unregistered [ 2269.849508] Key type ._llcrypt registered [ 2269.852195] Key type .llcrypt registered [ 2271.277564] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 09:20:56 (1783948856) [ 2273.772181] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2274.042521] alg: No test for adler32 (adler32-zlib) [ 2275.349785] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 2275.740819] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2277.479560] Key type lgssc registered [ 2279.329236] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2338.569613] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2345.269234] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2369.378230] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2372.198101] Lustre: Mounted lustre-client [ 2376.939514] Lustre: Unmounted lustre-client [ 2408.812342] Key type lgssc unregistered [ 2409.163258] LNet: 54047:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2409.174587] LNetError: 54047:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2409.189326] LNet: Removed LNI 192.168.204.48@tcp [ 2409.905963] Key type .llcrypt unregistered [ 2409.912853] Key type ._llcrypt unregistered [ 2428.346315] Key type ._llcrypt registered [ 2428.352859] Key type .llcrypt registered [ 2430.035156] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 09:23:35 (1783949015) [ 2433.414750] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2433.461759] alg: No test for adler32 (adler32-zlib) [ 2434.545081] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 2434.841150] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2436.615243] Key type lgssc registered [ 2437.832737] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2525.620840] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2565.215574] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2572.320506] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2610.620569] Key type lgssc unregistered [ 2610.931763] LNet: 57541:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2610.945557] LNetError: 57541:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2610.995691] LNet: Removed LNI 192.168.204.48@tcp [ 2611.672996] Key type .llcrypt unregistered [ 2611.682280] Key type ._llcrypt unregistered [ 2627.811327] Key type ._llcrypt registered [ 2627.817406] Key type .llcrypt registered [ 2629.702502] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 09:26:54 (1783949214) [ 2633.278058] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2633.549938] alg: No test for adler32 (adler32-zlib) [ 2634.591888] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 2635.005910] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 2636.743342] Key type lgssc registered [ 2638.087390] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2716.898777] Lustre: Mounted lustre-client [ 2725.308893] Lustre: Unmounted lustre-client [ 2767.200948] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 09:29:12 (1783949352) [ 2901.617602] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2918.170115] Lustre: Mounted lustre-client [ 2925.338442] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2925.348283] LustreError: 64026:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8e060802d000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2925.394794] Lustre: 58526:0:(llite_lib.c:4327:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.148@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2935.720912] Lustre: Unmounted lustre-client [ 2980.261961] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 09:32:45 (1783949565) [ 2990.658429] Key type lgssc unregistered [ 2990.911671] LNet: 65247:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2990.916714] LNetError: 65247:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2990.939451] LNet: Removed LNI 192.168.204.48@tcp [ 2991.612468] Key type .llcrypt unregistered [ 2991.622863] Key type ._llcrypt unregistered [ 3003.958790] Key type ._llcrypt registered [ 3003.961335] Key type .llcrypt registered [ 3004.436154] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3004.476780] alg: No test for adler32 (adler32-zlib) [ 3005.594083] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 3005.871565] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3007.624829] Key type lgssc registered [ 3009.161905] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3063.531767] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3069.586535] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3093.022593] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3094.831760] Lustre: Mounted lustre-client [ 3102.826304] Lustre: Unmounted lustre-client [ 3134.351517] Key type lgssc unregistered [ 3134.679505] LNet: 68261:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3134.686314] LNetError: 68261:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3134.731771] LNet: Removed LNI 192.168.204.48@tcp [ 3135.440835] Key type .llcrypt unregistered [ 3135.454975] Key type ._llcrypt unregistered [ 3148.100259] Key type ._llcrypt registered [ 3148.119357] Key type .llcrypt registered [ 3148.825886] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3148.855865] alg: No test for adler32 (adler32-zlib) [ 3149.961764] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 3150.299577] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3152.047378] Key type lgssc registered [ 3153.745199] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3266.284495] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3272.424603] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3293.481722] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3295.068697] Lustre: Mounted lustre-client [ 3302.571758] Lustre: Unmounted lustre-client [ 3330.113132] Key type lgssc unregistered [ 3330.469596] LNet: 71697:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3330.484187] LNetError: 71697:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3330.502289] LNet: Removed LNI 192.168.204.48@tcp [ 3331.289691] Key type .llcrypt unregistered [ 3331.296219] Key type ._llcrypt unregistered [ 3345.379842] Key type ._llcrypt registered [ 3345.381621] Key type .llcrypt registered [ 3346.940433] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 09:38:52 (1783949932) [ 3349.281335] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3349.436378] alg: No test for adler32 (adler32-zlib) [ 3350.443301] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 3350.644407] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3352.319247] Key type lgssc registered [ 3353.490386] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3403.706409] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3410.304807] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3435.053981] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3436.907090] Lustre: Mounted lustre-client [ 3448.271086] Lustre: Unmounted lustre-client [ 3448.716293] Lustre: Mounted lustre-client [ 3452.359548] Lustre: Unmounted lustre-client [ 3480.844600] Key type lgssc unregistered [ 3481.091591] LNet: 75381:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3481.109823] LNetError: 75381:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3481.135982] LNet: Removed LNI 192.168.204.48@tcp [ 3481.935710] Key type .llcrypt unregistered [ 3481.943081] Key type ._llcrypt unregistered [ 3495.614741] Key type ._llcrypt registered [ 3495.616925] Key type .llcrypt registered [ 3496.057895] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3496.087797] alg: No test for adler32 (adler32-zlib) [ 3497.176798] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 3497.527143] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3499.335255] Key type lgssc registered [ 3500.640046] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3555.824930] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3562.048435] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3585.978772] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3587.772955] Lustre: Mounted lustre-client [ 3592.415044] Lustre: Unmounted lustre-client [ 3620.947970] Key type lgssc unregistered [ 3621.211470] LNet: 78411:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3621.228397] LNetError: 78411:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3621.258324] LNet: Removed LNI 192.168.204.48@tcp [ 3622.057346] Key type .llcrypt unregistered [ 3622.058978] Key type ._llcrypt unregistered [ 3638.385407] Key type ._llcrypt registered [ 3638.389218] Key type .llcrypt registered [ 3639.881560] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 09:43:45 (1783950225) [ 3642.489295] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3642.549084] alg: No test for adler32 (adler32-zlib) [ 3643.777773] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 3644.166453] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3645.927153] Key type lgssc registered [ 3647.403532] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3702.457424] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3709.650497] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3734.569782] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3737.473742] Lustre: Mounted lustre-client [ 3743.371247] Lustre: lustre: root_squash is set to 0:0 [ 3752.052970] Lustre: lustre: nosquash_nids is cleared [ 3752.096332] Lustre: lustre: root_squash is set to 500:500 [ 3761.800699] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.48@tcp 192.168.0.[2,10]@tcp [ 3771.611597] Lustre: lustre: nosquash_nids set to 192.168.204.48/24@tcp [ 3778.724261] Lustre: Unmounted lustre-client [ 3809.018306] Key type lgssc unregistered [ 3809.394925] LNet: 82338:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3809.427823] LNetError: 82338:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3809.462112] LNet: Removed LNI 192.168.204.48@tcp [ 3810.235407] Key type .llcrypt unregistered [ 3810.236930] Key type ._llcrypt unregistered [ 3827.374090] Key type ._llcrypt registered [ 3827.376963] Key type .llcrypt registered [ 3828.955303] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 09:46:54 (1783950414) [ 3831.811132] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3833.797563] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 09:46:59 (1783950419) [ 3836.143973] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3836.178345] alg: No test for adler32 (adler32-zlib) [ 3837.238640] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 3837.594437] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 3839.327262] Key type lgssc registered [ 3841.025965] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3897.370349] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3905.642597] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3930.562159] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3932.481282] Lustre: lustre: root_squash is set to 500:500 [ 3932.497136] Lustre: lustre: nosquash_nids set to 192.168.204.48/24@tcp [ 3942.964777] Lustre: Mounted lustre-client [ 3950.637543] Lustre: Unmounted lustre-client [ 3979.722147] Key type lgssc unregistered [ 3980.057163] LNet: 86319:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3980.064619] LNetError: 86319:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3980.102358] LNet: Removed LNI 192.168.204.48@tcp [ 3980.963750] Key type .llcrypt unregistered [ 3980.966359] Key type ._llcrypt unregistered [ 3997.777817] Key type ._llcrypt registered [ 3997.782738] Key type .llcrypt registered [ 3999.356796] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4001.174120] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 09:49:46 (1783950586) [ 4021.620349] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4021.641683] alg: No test for adler32 (adler32-zlib) [ 4022.810970] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 4023.097362] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4024.815298] Key type lgssc registered [ 4026.060568] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4113.081329] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4118.925979] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4142.461064] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4211.173830] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4217.289839] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4238.365514] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4251.028190] Lustre: Mounted lustre-client [ 4286.996338] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8e0605779000.ost_server_uuid 50 [ 4289.338331] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8e0605779000.ost_server_uuid in FULL state after 0 sec [ 4289.806876] Lustre: Mounted lustre-client [ 4295.052443] Lustre: Unmounted lustre-client [ 4297.840731] Lustre: Unmounted lustre-client [ 4344.516057] Key type lgssc unregistered [ 4344.825878] LNet: 93994:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4344.835213] LNetError: 93994:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4344.852614] LNet: Removed LNI 192.168.204.48@tcp [ 4345.596652] Key type .llcrypt unregistered [ 4345.599103] Key type ._llcrypt unregistered [ 4382.128309] Key type ._llcrypt registered [ 4382.131928] Key type .llcrypt registered [ 4383.783155] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 09:56:09 (1783950969) [ 4404.880195] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4404.922966] alg: No test for adler32 (adler32-zlib) [ 4405.996625] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 4406.374044] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4408.151292] Key type lgssc registered [ 4409.730887] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4504.009958] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4511.482336] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4538.287610] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4541.104509] Lustre: Mounted lustre-client [ 4562.911860] Lustre: 95359:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783951133/real 1783951133] req@00000000f26afac4 x1870608196441344/t0(0) o400->lustre-OST0000-osc-ffff8e060641a000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1783951149 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4562.958465] Lustre: lustre-OST0000-osc-ffff8e060641a000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4567.519786] Lustre: 95359:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783951138/real 1783951138] req@0000000078923ac5 x1870608196441856/t0(0) o400->lustre-OST0000-osc-ffff8e060641a000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1783951154 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4572.639359] Lustre: 95359:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783951143/real 1783951143] req@0000000031c28005 x1870608196442368/t0(0) o400->lustre-OST0000-osc-ffff8e060641a000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1783951159 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4575.779592] Lustre: lustre-OST0000-osc-ffff8e060641a000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4577.825214] Lustre: 95359:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783951148/real 1783951148] req@000000009af4d1d6 x1870608196442880/t0(0) o400->lustre-OST0000-osc-ffff8e060641a000@192.168.204.148@tcp:28/4 lens 224/224 e 0 to 1 dl 1783951164 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4583.407069] Lustre: lustre-MDT0000-mdc-ffff8e060641a000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4599.655828] Lustre: 95359:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783951170/real 1783951170] req@00000000f72fc6a3 x1870608196445696/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1783951186 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4599.725208] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [ 4609.987697] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0x6a31857651548054 to 0x6a31857651548268 [ 4610.008506] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4615.453919] Lustre: lustre-MDT0000-mdc-ffff8e060641a000: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 4623.717936] Lustre: Unmounted lustre-client [ 4654.241553] Key type lgssc unregistered [ 4654.499754] LNet: 99670:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4654.513612] LNetError: 99670:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4654.530929] LNet: Removed LNI 192.168.204.48@tcp [ 4655.327157] Key type .llcrypt unregistered [ 4655.330874] Key type ._llcrypt unregistered [ 4675.642639] Key type ._llcrypt registered [ 4675.645771] Key type .llcrypt registered [ 4677.196224] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 10:01:02 (1783951262) [ 4692.906751] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4692.949117] alg: No test for adler32 (adler32-zlib) [ 4694.100563] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 4694.318955] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 4696.055206] Key type lgssc registered [ 4697.752410] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4741.901889] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4863.840311] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4870.293648] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4894.549944] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4897.399694] Lustre: Mounted lustre-client [ 4899.823813] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4902.161662] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 10:04:47 (1783951487) [ 5178.634885] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5188.950464] Lustre: Unmounted lustre-client [ 5323.342197] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5330.019795] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5357.511358] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5410.222989] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:13:16 (1783951996) [ 5514.970925] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5520.795603] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5545.047584] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5545.658777] Lustre: Mounted lustre-client [ 5550.692624] Lustre: Unmounted lustre-client [ 5582.953582] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:16:08 (1783952168) [ 5690.321880] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5698.360295] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5724.456842] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5725.472753] Lustre: Mounted lustre-client [ 5731.372942] Lustre: Unmounted lustre-client [ 5759.964554] Key type lgssc unregistered [ 5760.305812] LNet: 122721:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5760.316678] LNetError: 122721:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5760.341731] LNet: Removed LNI 192.168.204.48@tcp [ 5761.190782] Key type .llcrypt unregistered [ 5761.195036] Key type ._llcrypt unregistered [ 5779.634440] Key type ._llcrypt registered [ 5779.642714] Key type .llcrypt registered [ 5781.313479] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 10:19:26 (1783952366) [ 5783.923047] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5783.969664] alg: No test for adler32 (adler32-zlib) [ 5785.131088] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 5785.437063] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5787.223228] Key type lgssc registered [ 5788.649881] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5842.227618] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5848.113948] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5871.249504] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5873.141895] Lustre: Mounted lustre-client [ 5890.124685] Lustre: Unmounted lustre-client [ 5928.084726] Key type lgssc unregistered [ 5928.431800] LNet: 126316:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5928.447826] LNetError: 126316:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5928.468321] LNet: Removed LNI 192.168.204.48@tcp [ 5929.336938] Key type .llcrypt unregistered [ 5929.339573] Key type ._llcrypt unregistered [ 5947.863426] Key type ._llcrypt registered [ 5947.865894] Key type .llcrypt registered [ 5949.212587] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 10:22:14 (1783952534) [ 5952.225052] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5952.246845] alg: No test for adler32 (adler32-zlib) [ 5953.324844] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 5953.574507] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 5955.247505] Key type lgssc registered [ 5956.571554] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6008.202594] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6014.745051] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6039.775713] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6041.868365] Lustre: Mounted lustre-client [ 6047.223758] Lustre: lustre-OST0000-osc-ffff8e060641f000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6069.897115] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8e060641f000.ost_server_uuid 50 [ 6071.986192] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6084.291342] Lustre: Unmounted lustre-client [ 6108.826845] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 10:24:54 (1783952694) [ 6148.606252] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6156.297677] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6181.044759] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6206.778257] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6207.523342] Lustre: Mounted lustre-client [ 6212.588934] Lustre: lustre-OST0000-osc-ffff8e06040ab000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6240.176074] Lustre: Unmounted lustre-client [ 6294.314986] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 10:28:00 (1783952880) [ 6329.706835] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6335.656576] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6358.400204] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6381.820779] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6382.653790] Lustre: Mounted lustre-client [ 6387.706768] Lustre: lustre-OST0000-osc-ffff8e06074a2000: Connection to lustre-OST0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6404.845092] Lustre: Unmounted lustre-client [ 6454.673855] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 10:30:40 (1783953040) [ 6567.547768] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6574.079813] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6599.100724] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6673.320891] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6680.094609] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6702.854584] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6742.465993] Lustre: Mounted lustre-client [ 6784.388671] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6789.629713] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 6791.863970] Lustre: Unmounted lustre-client [ 6826.177215] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 10:36:51 (1783953411) [ 6863.244430] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6869.712149] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6892.215056] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6928.925659] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6969.847069] Lustre: Mounted lustre-client [ 7023.116570] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7025.541337] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7039.742754] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7050.101073] Lustre: Unmounted lustre-client [ 7107.781366] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 10:41:32 (1783953692) [ 7148.965426] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7156.374530] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7181.860689] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7182.702088] Lustre: Mounted lustre-client [ 7209.953721] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7211.849419] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7229.790563] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8e06074a6000.ost_server_uuid 50 [ 7231.462239] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8e06074a6000.ost_server_uuid in IDLE state after 0 sec [ 7235.369538] Lustre: Unmounted lustre-client [ 7235.841743] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7235.850494] Lustre: Skipped 3 previous similar messages [ 7236.013916] Lustre: Mounted lustre-client [ 7237.596605] LustreError: 149769:0:(sec.c:413:import_sec_validate_get()) import 000000000b0ef7ef (NEW) with no sec [ 7305.268823] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 10:44:50 (1783953890) [ 7347.000369] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7354.586113] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7380.821695] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7406.988722] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7407.742081] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7407.961899] Lustre: Mounted lustre-client [ 7424.264234] Lustre: Unmounted lustre-client [ 7424.269716] Lustre: Skipped 1 previous similar message [ 7467.243798] Key type lgssc unregistered [ 7467.639352] LNet: 153191:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7467.652327] LNetError: 153191:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7467.669064] LNet: Removed LNI 192.168.204.48@tcp [ 7468.573138] Key type .llcrypt unregistered [ 7468.574760] Key type ._llcrypt unregistered [ 7488.761674] Key type ._llcrypt registered [ 7488.765050] Key type .llcrypt registered [ 7490.587098] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 10:47:55 (1783954075) [ 7492.348539] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7492.362443] alg: No test for adler32 (adler32-zlib) [ 7493.333277] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 7493.540146] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7495.297218] Key type lgssc registered [ 7496.563690] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7561.182664] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7568.638682] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7592.260246] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7617.039762] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7618.744122] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7619.980768] Lustre: Mounted lustre-client [ 7623.997919] LustreError: lustre-MDT0001-mdc-ffff8e0602b9c800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7624.020974] Lustre: lustre-MDT0001-mdc-ffff8e0602b9c800: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [ 7630.499264] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7632.718450] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7657.498279] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7663.765703] Lustre: Unmounted lustre-client [ 7701.969193] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 10:51:26 (1783954286) [ 7816.958236] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7823.735988] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7850.413283] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7851.242888] Lustre: Mounted lustre-client [ 7882.040672] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7884.411260] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7898.366293] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7908.722115] Lustre: Unmounted lustre-client [ 7945.253666] Key type lgssc unregistered [ 7945.600852] LNet: 162806:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7945.605735] LNetError: 162806:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7945.623075] LNet: Removed LNI 192.168.204.48@tcp [ 7946.339523] Key type .llcrypt unregistered [ 7946.341828] Key type ._llcrypt unregistered [ 7978.275804] Key type ._llcrypt registered [ 7978.277479] Key type .llcrypt registered [ 7979.576414] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 10:56:05 (1783954565) [ 7982.183137] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7982.222163] alg: No test for adler32 (adler32-zlib) [ 7983.322927] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 7983.544713] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 7985.263241] Key type lgssc registered [ 7986.724097] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8040.888547] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8048.041409] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8071.080589] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8072.791269] Lustre: Mounted lustre-client [ 8120.192671] Lustre: Unmounted lustre-client [ 8161.515185] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8162.258912] Lustre: Mounted lustre-client [ 8199.023798] Lustre: Unmounted lustre-client [ 8236.966831] Key type lgssc unregistered [ 8237.280510] LNet: 167252:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8237.286949] LNetError: 167252:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8238.312046] LNet: Removed LNI 192.168.204.48@tcp [ 8239.186762] Key type .llcrypt unregistered [ 8239.189840] Key type ._llcrypt unregistered [ 8256.937400] Key type ._llcrypt registered [ 8256.940332] Key type .llcrypt registered [ 8258.780677] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 11:00:43 (1783954843) [ 8261.855208] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8261.879042] alg: No test for adler32 (adler32-zlib) [ 8262.975640] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 8263.347804] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8265.111712] Key type lgssc registered [ 8266.932139] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8322.146625] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8328.851259] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8350.518970] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8352.547767] Lustre: Mounted lustre-client [ 8376.055698] Lustre: Unmounted lustre-client [ 8403.660496] Key type lgssc unregistered [ 8403.955947] LNet: 171016:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8403.965400] LNetError: 171016:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8403.995819] LNet: Removed LNI 192.168.204.48@tcp [ 8404.782850] Key type .llcrypt unregistered [ 8404.787338] Key type ._llcrypt unregistered [ 8419.534423] Key type ._llcrypt registered [ 8419.545464] Key type .llcrypt registered [ 8420.005487] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8420.024166] alg: No test for adler32 (adler32-zlib) [ 8421.159835] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 8421.495351] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8423.184699] Key type lgssc registered [ 8424.880659] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8483.818460] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8490.586713] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8514.585470] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8525.959294] Lustre: Mounted lustre-client [ 8535.190931] Lustre: Unmounted lustre-client [ 8559.132638] Key type lgssc unregistered [ 8559.370264] LNet: 174080:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8559.380930] LNetError: 174080:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8559.401957] LNet: Removed LNI 192.168.204.48@tcp [ 8560.048404] Key type .llcrypt unregistered [ 8560.051036] Key type ._llcrypt unregistered [ 8578.272764] Key type ._llcrypt registered [ 8578.274499] Key type .llcrypt registered [ 8580.056714] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 11:06:05 (1783955165) [ 8583.269687] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8583.321226] alg: No test for adler32 (adler32-zlib) [ 8584.717363] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 8585.315687] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8587.172753] Key type lgssc registered [ 8588.927531] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8642.848142] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8650.384207] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8680.692560] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8682.676719] Lustre: Mounted lustre-client [ 8705.623183] Lustre: Unmounted lustre-client [ 8735.614456] Key type lgssc unregistered [ 8735.822530] LNet: 177830:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8735.831215] LNetError: 177830:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8735.863468] LNet: Removed LNI 192.168.204.48@tcp [ 8736.756152] Key type .llcrypt unregistered [ 8736.766370] Key type ._llcrypt unregistered [ 8753.086746] Key type ._llcrypt registered [ 8753.088944] Key type .llcrypt registered [ 8753.860687] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8753.878947] alg: No test for adler32 (adler32-zlib) [ 8755.244076] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 8755.487709] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8757.159170] Key type lgssc registered [ 8759.043446] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8816.539861] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8824.675449] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8852.140312] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8859.205645] Lustre: Mounted lustre-client [ 8867.866206] Lustre: Unmounted lustre-client [ 8900.233237] Key type lgssc unregistered [ 8900.545978] LNet: 180901:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8900.550753] LNetError: 180901:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8901.628397] LNet: Removed LNI 192.168.204.48@tcp [ 8902.421953] Key type .llcrypt unregistered [ 8902.423493] Key type ._llcrypt unregistered [ 8921.341880] Key type ._llcrypt registered [ 8921.345281] Key type .llcrypt registered [ 8923.317728] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 11:11:48 (1783955508) [ 8948.499276] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8948.519513] alg: No test for adler32 (adler32-zlib) [ 8949.722220] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 8950.080428] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 8951.863804] Key type lgssc registered [ 8953.593394] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9044.147303] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9050.647366] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9076.258391] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9120.784720] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 11:15:06 (1783955706) [ 9154.646180] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9160.489257] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9184.205529] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9186.155667] Lustre: Mounted lustre-client [ 9194.376090] Lustre: Unmounted lustre-client [ 9222.976456] Key type lgssc unregistered [ 9223.249758] LNet: 187999:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9223.256783] LNetError: 187999:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9223.272181] LNet: Removed LNI 192.168.204.48@tcp [ 9224.000828] Key type .llcrypt unregistered [ 9224.003655] Key type ._llcrypt unregistered [ 9241.260031] Key type ._llcrypt registered [ 9241.262441] Key type .llcrypt registered [ 9242.717715] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9244.553897] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 11:17:09 (1783955829) [ 9267.138228] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9267.246292] alg: No test for adler32 (adler32-zlib) [ 9268.475341] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 9268.810576] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 9270.519216] Key type lgssc registered [ 9271.871446] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9377.010357] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9383.503202] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9408.949898] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9433.588239] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9435.734731] Lustre: Mounted lustre-client [ 9462.470568] Lustre: Unmounted lustre-client [ 9592.295489] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9598.566882] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9627.368839] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9680.222731] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 11:24:25 (1783956265) [ 9681.922312] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 9684.149574] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 11:24:29 (1783956269) [ 9794.586713] Key type lgssc unregistered [ 9794.857307] LNet: 199444:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9794.867993] LNetError: 199444:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9794.889982] LNet: Removed LNI 192.168.204.48@tcp [ 9795.776273] Key type .llcrypt unregistered [ 9795.781261] Key type ._llcrypt unregistered [ 9811.812281] Key type ._llcrypt registered [ 9811.818598] Key type .llcrypt registered [ 9813.529177] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 11:26:38 (1783956398) [ 9857.047666] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9857.070396] alg: No test for adler32 (adler32-zlib) [ 9858.257656] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [ 9858.499444] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [ 9860.135499] Key type lgssc registered [ 9861.461953] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9914.920408] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9920.946380] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9957.773705] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9987.351740] Key type lgssc unregistered [ 9987.698875] LNet: 203179:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9987.706800] LNetError: 203179:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9987.726435] LNet: Removed LNI 192.168.204.48@tcp [ 9988.556105] Key type .llcrypt unregistered [ 9988.561220] Key type ._llcrypt unregistered [10005.801282] Key type ._llcrypt registered [10005.804294] Key type .llcrypt registered [10007.110211] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 11:29:52 (1783956592) [10009.945643] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10010.053942] alg: No test for adler32 (adler32-zlib) [10011.207929] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10011.500911] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [10013.290953] Key type lgssc registered [10014.738537] Lustre: Echo OBD driver; http://www.lustre.org/ [10067.840407] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10075.269571] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10101.476606] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10112.633074] Lustre: Mounted lustre-client [10122.745764] Lustre: lustre-MDT0000-mdc-ffff8e060641e800: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [10132.993169] Lustre: lustre-MDT0001-mdc-ffff8e060641e800: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [10143.969642] Lustre: 204170:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783956714/real 1783956714] req@0000000089e4e307 x1870614073786880/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1783956730 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10144.014755] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [10169.838963] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0xb3c1fb0bbf58d0fa to 0xb3c1fb0bbf58ebaa [10169.860782] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [10200.578654] LustreError: lustre-MDT0000-mdc-ffff8e060641e800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10200.610917] Lustre: lustre-MDT0000-mdc-ffff8e060641e800: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [10207.113982] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10209.730692] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10215.650251] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10217.705548] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10221.522467] Lustre: Unmounted lustre-client [10256.834468] Key type lgssc unregistered [10257.251352] LNet: 208127:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10257.269030] LNetError: 208127:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10258.349907] LNet: Removed LNI 192.168.204.48@tcp [10259.422658] Key type .llcrypt unregistered [10259.425808] Key type ._llcrypt unregistered [10276.657418] Key type ._llcrypt registered [10276.659179] Key type .llcrypt registered [10278.213747] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 11:34:23 (1783956863) [10280.829995] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10280.851367] alg: No test for adler32 (adler32-zlib) [10281.996918] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10282.248320] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [10283.923902] Key type lgssc registered [10285.167635] Lustre: Echo OBD driver; http://www.lustre.org/ [10331.892450] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10338.960506] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10398.957550] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10405.101574] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10442.924471] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10470.950416] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10512.093291] Key type lgssc unregistered [10512.307448] LNet: 213422:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10512.316966] LNetError: 213422:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10512.338703] LNet: Removed LNI 192.168.204.48@tcp [10513.052113] Key type .llcrypt unregistered [10513.053845] Key type ._llcrypt unregistered [10557.622580] Key type ._llcrypt registered [10557.625516] Key type .llcrypt registered [10558.883507] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 11:39:04 (1783957144) [10601.545257] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10601.577770] alg: No test for adler32 (adler32-zlib) [10602.724671] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [10602.972333] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [10604.703672] Key type lgssc registered [10605.900939] Lustre: Echo OBD driver; http://www.lustre.org/ [10694.753528] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10700.536624] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10723.923755] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10767.894503] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 11:42:33 (1783957353) [10775.776459] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 11:42:41 (1783957361) [10815.799871] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10822.034457] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10845.668269] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10848.695416] Lustre: Mounted lustre-client [10854.474977] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10856.266917] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10858.012509] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10860.194577] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10864.108321] Lustre: lustre-MDT0000-mdc-ffff8e0606419800: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [10880.506849] Lustre: 215319:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783957451/real 1783957451] req@000000009f9fac8d x1870614694471296/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1783957467 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10880.559173] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [10890.732433] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0x9bdbd91ac528b6c5 to 0x9bdbd91ac528b838 [10890.758848] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [10897.717088] Lustre: lustre-MDT0000-mdc-ffff8e0606419800: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [10908.845514] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10910.643912] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10914.854582] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10921.474165] Lustre: lustre-MDT0000-mdc-ffff8e0606419800: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [10937.823295] Lustre: 215318:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1783957508/real 1783957508] req@000000003c4e26a9 x1870614694481024/t0(0) o400->MGC192.168.204.148@tcp@192.168.204.148@tcp:26/25 lens 224/224 e 0 to 1 dl 1783957524 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10937.848199] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [10947.060496] Lustre: Evicted from MGS (at 192.168.204.148@tcp) after server handle changed from 0x9bdbd91ac528b838 to 0x9bdbd91ac528bc44 [10947.106359] Lustre: MGC192.168.204.148@tcp: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [10950.488663] Lustre: lustre-MDT0000-mdc-ffff8e0606419800: Connection restored to 192.168.204.148@tcp (at 192.168.204.148@tcp) [10962.320426] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10964.366089] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10968.655018] Lustre: Unmounted lustre-client [11041.874276] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11048.566331] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11075.161252] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11075.952812] Lustre: Mounted lustre-client [11079.077180] Lustre: Unmounted lustre-client [11108.217841] Key type lgssc unregistered [11108.548114] LNet: 225901:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11108.557730] LNetError: 225901:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11108.578716] LNet: Removed LNI 192.168.204.48@tcp [11109.337694] Key type .llcrypt unregistered [11109.341698] Key type ._llcrypt unregistered [11126.480983] Key type ._llcrypt registered [11126.482559] Key type .llcrypt registered [11128.174525] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 11:48:33 (1783957713) [11133.420483] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11133.452158] alg: No test for adler32 (adler32-zlib) [11134.577845] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [11134.949643] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11136.671628] Key type lgssc registered [11138.142921] Lustre: Echo OBD driver; http://www.lustre.org/ [11196.024978] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11203.258761] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11227.356788] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11239.467928] Lustre: Mounted lustre-client [11247.055172] Lustre: Unmounted lustre-client [11317.939451] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11326.504248] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11349.181752] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11350.137345] Lustre: Mounted lustre-client [11359.087221] Lustre: Unmounted lustre-client [11428.473312] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11434.839228] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11455.973208] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11456.640424] Lustre: Mounted lustre-client [11459.236165] Lustre: Unmounted lustre-client [11484.247588] Key type lgssc unregistered [11484.641140] LNet: 232955:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11484.650972] LNetError: 232955:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11484.682451] LNet: Removed LNI 192.168.204.48@tcp [11485.461080] Key type .llcrypt unregistered [11485.463355] Key type ._llcrypt unregistered [11503.571441] Key type ._llcrypt registered [11503.573865] Key type .llcrypt registered [11504.859991] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 11:54:50 (1783958090) [11508.113638] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11508.303824] alg: No test for adler32 (adler32-zlib) [11509.487933] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [11509.842838] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11511.559299] Key type lgssc registered [11513.001141] Lustre: Echo OBD driver; http://www.lustre.org/ [11558.516231] Key type lgssc unregistered [11558.767853] LNet: 235275:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11558.777347] LNetError: 235275:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11558.799718] LNet: Removed LNI 192.168.204.48@tcp [11559.461347] Key type .llcrypt unregistered [11559.463915] Key type ._llcrypt unregistered [11588.794269] Key type ._llcrypt registered [11588.806282] Key type .llcrypt registered [11589.396707] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11589.422702] alg: No test for adler32 (adler32-zlib) [11590.536715] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [11590.931348] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11592.647272] Key type lgssc registered [11594.191792] Lustre: Echo OBD driver; http://www.lustre.org/ [11680.277780] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11686.232789] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11711.409047] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11755.643420] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [11757.924686] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 11:59:02 (1783958342) [11793.269121] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11799.464420] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11820.774239] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11848.542884] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11850.314592] Lustre: Mounted lustre-client [11855.347073] Lustre: lustre-OST0001-osc-ffff8e0610519000: Connection to lustre-OST0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [11863.302896] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11873.716325] Lustre: Unmounted lustre-client [11927.524127] Key type lgssc unregistered [11927.823925] LNet: 242401:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11927.840904] LNetError: 242401:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11927.868071] LNet: Removed LNI 192.168.204.48@tcp [11928.616075] Key type .llcrypt unregistered [11928.622317] Key type ._llcrypt unregistered [11962.790127] Key type ._llcrypt registered [11962.791674] Key type .llcrypt registered [11964.589583] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 12:02:29 (1783958549) [11979.378955] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11979.462664] alg: No test for adler32 (adler32-zlib) [11980.711210] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [11981.133561] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [11982.936372] Key type lgssc registered [11984.526562] Lustre: Echo OBD driver; http://www.lustre.org/ [12041.348637] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12047.890649] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12071.667216] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 12:04:16 (1783958656) [12110.132476] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12116.982808] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12141.030820] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12143.663138] Lustre: Mounted lustre-client [12150.697523] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12173.633749] Lustre: Unmounted lustre-client [12279.340554] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12285.750810] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12339.806757] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12340.528932] Lustre: Mounted lustre-client [12343.828560] Lustre: Unmounted lustre-client [12371.928221] Key type lgssc unregistered [12372.245966] LNet: 250103:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12372.255414] LNetError: 250103:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12372.280713] LNet: Removed LNI 192.168.204.48@tcp [12372.975572] Key type .llcrypt unregistered [12372.979633] Key type ._llcrypt unregistered [12404.875919] Key type ._llcrypt registered [12404.905534] Key type .llcrypt registered [12405.244669] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12405.330662] alg: No test for adler32 (adler32-zlib) [12406.530376] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [12406.943619] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [12408.655235] Key type lgssc registered [12409.979467] Lustre: Echo OBD driver; http://www.lustre.org/ [12500.253790] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12507.525637] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12532.729717] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12573.837951] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [12576.407680] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 12:12:41 (1783959161) [12611.959983] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12617.559309] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12639.668293] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12644.624947] Lustre: Mounted lustre-client [12648.927782] Lustre: Unmounted lustre-client [12677.528239] Key type lgssc unregistered [12677.951299] LNet: 256739:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12677.956491] LNetError: 256739:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12677.987612] LNet: Removed LNI 192.168.204.48@tcp [12679.244900] Key type .llcrypt unregistered [12679.249041] Key type ._llcrypt unregistered [12697.036952] Key type ._llcrypt registered [12697.039769] Key type .llcrypt registered [12698.496891] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [12700.454369] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 12:14:45 (1783959285) [12709.140522] Key type .llcrypt unregistered [12709.143878] Key type ._llcrypt unregistered [12717.709511] Key type ._llcrypt registered [12717.716599] Key type .llcrypt registered [12718.389779] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12718.403333] alg: No test for adler32 (adler32-zlib) [12719.834159] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [12720.148897] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [12721.864174] Key type lgssc registered [12723.108496] Lustre: Echo OBD driver; http://www.lustre.org/ [12774.975306] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12791.730827] Lustre: Mounted lustre-client [12794.759577] Lustre: Unmounted lustre-client [12819.161624] Key type lgssc unregistered [12819.475632] LNet: 260191:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12819.504209] LNetError: 260191:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12819.544329] LNet: Removed LNI 192.168.204.48@tcp [12820.489537] Key type .llcrypt unregistered [12820.492925] Key type ._llcrypt unregistered [12838.975343] Key type ._llcrypt registered [12838.978325] Key type .llcrypt registered [12840.593122] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 12:17:05 (1783959425) [12843.356368] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12843.404293] alg: No test for adler32 (adler32-zlib) [12844.615146] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [12845.018098] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [12846.751470] Key type lgssc registered [12848.319315] Lustre: Echo OBD driver; http://www.lustre.org/ [12936.169627] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12970.818563] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12976.271695] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12979.007813] Lustre: Mounted lustre-client [12981.496379] Lustre: Unmounted lustre-client [13011.906290] Key type lgssc unregistered [13012.142829] LNet: 263737:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13012.152164] LNetError: 263737:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13012.205487] LNet: Removed LNI 192.168.204.48@tcp [13012.990319] Key type .llcrypt unregistered [13012.993649] Key type ._llcrypt unregistered [13028.999676] Key type ._llcrypt registered [13029.006391] Key type .llcrypt registered [13030.678733] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 12:20:15 (1783959615) [13033.719775] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13033.772693] alg: No test for adler32 (adler32-zlib) [13034.999781] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [13035.506698] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [13037.328461] Key type lgssc registered [13039.308932] Lustre: Echo OBD driver; http://www.lustre.org/ [13092.514915] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13099.247451] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13121.991208] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13124.834541] Lustre: Mounted lustre-client [13130.217482] Lustre: lustre-MDT0000-mdc-ffff8e06215f7000: Connection to lustre-MDT0000 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [13135.774336] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13135.818626] LustreError: 266893:0:(file.c:6088:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13136.292845] LustreError: MGC192.168.204.148@tcp: Connection to MGS (at 192.168.204.148@tcp) was lost; in progress operations using this service will fail [13136.398938] Lustre: Unmounted lustre-client [13158.626876] Key type lgssc unregistered [13158.841740] LNet: 267306:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13158.849180] LNetError: 267306:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13158.866888] LNet: Removed LNI 192.168.204.48@tcp [13159.452939] Key type .llcrypt unregistered [13159.457657] Key type ._llcrypt unregistered [13177.007934] Key type ._llcrypt registered [13177.011647] Key type .llcrypt registered [13178.565316] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 12:22:43 (1783959763) [13181.431962] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13181.479094] alg: No test for adler32 (adler32-zlib) [13182.607773] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [13182.874731] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [13184.599195] Key type lgssc registered [13186.558216] Lustre: Echo OBD driver; http://www.lustre.org/ [13244.384379] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13251.424214] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13275.201886] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13277.934589] Lustre: Mounted lustre-client [13283.314760] Lustre: lustre-MDT0001-mdc-ffff8e0603efe000: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [13288.808358] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13291.238443] Lustre: Unmounted lustre-client [13311.579637] Key type lgssc unregistered [13311.879954] LNet: 270888:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13311.894097] LNetError: 270888:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13311.919707] LNet: Removed LNI 192.168.204.48@tcp [13312.720820] Key type .llcrypt unregistered [13312.723586] Key type ._llcrypt unregistered [13329.222482] Key type ._llcrypt registered [13329.224474] Key type .llcrypt registered [13330.893279] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 12:25:16 (1783959916) [13351.047434] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13351.069716] alg: No test for adler32 (adler32-zlib) [13352.169587] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [13352.449749] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [13354.183227] Key type lgssc registered [13355.719284] Lustre: Echo OBD driver; http://www.lustre.org/ [13469.293306] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13472.065752] Lustre: Mounted lustre-client [13510.632491] Lustre: lustre-MDT0001-mdc-ffff8e06065c9800: Connection to lustre-MDT0001 (at 192.168.204.148@tcp) was lost; in progress operations using this service will wait for recovery to complete [13521.353919] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13531.674401] Lustre: Unmounted lustre-client [13560.024345] Key type lgssc unregistered [13560.302855] LNet: 276671:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13560.320549] LNetError: 276671:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13560.347340] LNet: Removed LNI 192.168.204.48@tcp [13561.221452] Key type .llcrypt unregistered [13561.227460] Key type ._llcrypt unregistered [13579.196496] Key type ._llcrypt registered [13579.198710] Key type .llcrypt registered [13580.860447] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 12:29:26 (1783960166) [13582.550508] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [13584.278633] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 12:29:29 (1783960169) [13586.453754] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [13588.509806] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 12:29:33 (1783960173) [13590.325906] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [13592.273344] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 12:29:37 (1783960177) [13594.257763] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [13596.165656] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 12:29:41 (1783960181) [13597.790845] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [13599.701514] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 12:29:45 (1783960185) [13609.827310] Key type .llcrypt unregistered [13609.830411] Key type ._llcrypt unregistered [13618.586403] Key type ._llcrypt registered [13618.590816] Key type .llcrypt registered [13619.007858] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13619.035615] alg: No test for adler32 (adler32-zlib) [13620.325298] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [13620.665910] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [13622.392556] Key type lgssc registered [13623.896748] Lustre: Echo OBD driver; http://www.lustre.org/ [13705.893548] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13712.233964] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13737.739672] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13739.691967] Lustre: Mounted lustre-client [13742.451282] Lustre: Unmounted lustre-client [13786.401105] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 12:32:51 (1783960371) [13826.576312] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13834.230587] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13872.196539] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13873.071765] Lustre: Mounted lustre-client [13875.675750] Lustre: Unmounted lustre-client [13916.464465] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 12:35:01 (1783960501) [13935.071549] LNet: 1 local NIs in recovery (showing 1): 192.168.204.48@tcp [14569.037711] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14575.154349] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14612.524793] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14716.777968] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 12:48:21 (1783961301) [14730.164502] Key type lgssc unregistered [14730.498914] LNet: 290202:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14730.512757] LNetError: 290202:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14730.543898] LNet: Removed LNI 192.168.204.48@tcp [14731.513377] Key type .llcrypt unregistered [14731.518789] Key type ._llcrypt unregistered [14858.814770] Key type ._llcrypt registered [14858.820626] Key type .llcrypt registered [14859.252177] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14859.264843] alg: No test for adler32 (adler32-zlib) [14860.404837] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [14860.623522] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [14862.305336] Key type lgssc registered [14863.786137] Lustre: Echo OBD driver; http://www.lustre.org/ [14960.299725] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14966.222498] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14988.649509] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15022.027601] Key type lgssc unregistered [15022.322753] LNet: 293896:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15022.346396] LNetError: 293896:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15022.387481] LNet: Removed LNI 192.168.204.48@tcp [15023.281328] Key type .llcrypt unregistered [15023.283359] Key type ._llcrypt unregistered [15066.088443] Key type ._llcrypt registered [15066.091233] Key type .llcrypt registered [15067.580600] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 12:54:12 (1783961652) [15091.268071] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15091.283756] alg: No test for adler32 (adler32-zlib) [15092.498331] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [15092.940385] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [15094.671498] Key type lgssc registered [15096.754652] Lustre: Echo OBD driver; http://www.lustre.org/ [15157.398207] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 12:55:43 (1783961743) [15168.624486] Key type lgssc unregistered [15168.916624] LNet: 297456:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15168.931044] LNetError: 297456:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15168.954230] LNet: Removed LNI 192.168.204.48@tcp [15169.557632] Key type .llcrypt unregistered [15169.562146] Key type ._llcrypt unregistered [15180.733599] Key type ._llcrypt registered [15180.740700] Key type .llcrypt registered [15181.312667] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15181.346362] alg: No test for adler32 (adler32-zlib) [15182.608692] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [15182.878425] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [15184.607214] Key type lgssc registered [15186.076096] Lustre: Echo OBD driver; http://www.lustre.org/ [15245.783460] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15252.411569] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15280.927801] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15604.230628] LNet: Added LNI 192.168.204.48@tcp50 [8/256/0/180] [15606.932381] LNet: Removed LNI 192.168.204.48@tcp [15609.140933] Lustre: 301871:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8e0610609800: config has no valid NIDs, force dynamic NIDs [15610.388761] Lustre: Mounted lustre-client [15610.613793] Lustre: Unmounted lustre-client [15613.854652] Key type lgssc unregistered [15614.242426] LNet: 302130:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15614.252446] LNetError: 302130:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15614.277390] LNet: Removed LNI 192.168.204.48@tcp50 [15615.047260] Key type .llcrypt unregistered [15615.049252] Key type ._llcrypt unregistered [15632.463480] Key type ._llcrypt registered [15632.467470] Key type .llcrypt registered [15632.906623] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15632.918635] alg: No test for adler32 (adler32-zlib) [15634.036589] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [15634.308236] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [15636.039179] Key type lgssc registered [15637.409766] Lustre: Echo OBD driver; http://www.lustre.org/ [15701.820511] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15707.104803] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15714.157220] LNet: Added LNI 192.168.204.48@tcp50 [8/256/0/180] [15715.289378] LNet: Removed LNI 192.168.204.48@tcp [15716.486065] Lustre: 304825:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff8e0610769800: config has no valid NIDs, force dynamic NIDs [15717.631740] Lustre: Mounted lustre-client [15718.207100] Lustre: Unmounted lustre-client [15769.488801] Key type lgssc unregistered [15769.907983] LNet: 305698:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15769.919265] LNetError: 305698:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15769.961122] LNet: Removed LNI 192.168.204.48@tcp50 [15770.620062] Key type .llcrypt unregistered [15770.624922] Key type ._llcrypt unregistered [15782.894427] Key type ._llcrypt registered [15782.896687] Key type .llcrypt registered [15784.330980] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 13:06:09 (1783962369) [15802.194227] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15802.246130] alg: No test for adler32 (adler32-zlib) [15803.257878] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [15803.437026] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [15805.103179] Key type lgssc registered [15806.631463] Lustre: Echo OBD driver; http://www.lustre.org/ [15890.991290] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15896.490941] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15920.904955] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15961.063111] Key type lgssc unregistered [15961.295869] LNet: 310445:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15961.303521] LNetError: 310445:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15961.340190] LNet: Removed LNI 192.168.204.48@tcp [15962.120876] Key type .llcrypt unregistered [15962.124352] Key type ._llcrypt unregistered [15973.754261] Key type ._llcrypt registered [15973.756356] Key type .llcrypt registered [15974.976659] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 13:09:20 (1783962560) [15978.370766] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15978.389944] alg: No test for adler32 (adler32-zlib) [15979.856277] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [15980.246700] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [15982.079312] Key type lgssc registered [15983.681610] Lustre: Echo OBD driver; http://www.lustre.org/ [16039.527101] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16045.165694] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16066.263784] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16068.776101] Lustre: Mounted lustre-client [16135.845246] Lustre: Mounted fs15246-client [16152.098212] Lustre: Unmounted fs15246-client [16181.134651] Lustre: Unmounted lustre-client [16209.289133] Key type lgssc unregistered [16209.555561] LNet: 315305:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16209.562053] LNetError: 315305:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16209.578416] LNet: Removed LNI 192.168.204.48@tcp [16210.273104] Key type .llcrypt unregistered [16210.276662] Key type ._llcrypt unregistered [16221.831093] Key type ._llcrypt registered [16221.836399] Key type .llcrypt registered [16223.221138] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 13:13:28 (1783962808) [16225.121083] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16225.173269] alg: No test for adler32 (adler32-zlib) [16226.344223] Lustre: Lustre: Build Version: 2.17.54_162_ga4ac164 [16226.622059] LNet: Added LNI 192.168.204.48@tcp [8/256/0/180] [16228.367195] Key type lgssc registered [16229.733406] Lustre: Echo OBD driver; http://www.lustre.org/ [16370.046681] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16377.868814] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16400.951789] Lustre: DEBUG MARKER: oleg448-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16512.048231] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16185 sec ========= 13:18:17 (1783963097) [16513.993761] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 13:18:19 (1783963099) === [16517.967871] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 13:18:23 (1783963103) === [16553.924710] Key type lgssc unregistered [16554.185235] LNet: 324566:0:(lib-ptl.c:967:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16554.196833] LNetError: 324566:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16554.231724] LNet: Removed LNI 192.168.204.48@tcp [16554.996399] Key type .llcrypt unregistered [16555.005968] Key type ._llcrypt unregistered