[ 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 459772599 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2895288K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524580K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001013] APIC: Switch to symmetric I/O mode setup [ 0.002389] x2apic enabled [ 0.003009] Switched APIC routing to physical x2apic. [ 0.004015] kvm-guest: setup PV IPIs [ 0.007000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.007000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008019] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009013] pid_max: default: 32768 minimum: 301 [ 0.010158] LSM: Security Framework initializing [ 0.011057] Yama: becoming mindful. [ 0.012045] SELinux: Initializing. [ 0.013083] *** VALIDATE selinux *** [ 0.022045] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026815] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.028147] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030011] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.031140] *** VALIDATE tmpfs *** [ 0.033275] *** VALIDATE proc *** [ 0.034249] *** VALIDATE cgroup *** [ 0.036010] *** VALIDATE cgroup2 *** [ 0.037268] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.038141] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.040007] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.041028] Spectre V2 : User space: Vulnerable [ 0.042012] Speculative Store Bypass: Vulnerable [ 0.045142] debug: unmapping init [mem 0xffffffffb3a59000-0xffffffffb3a60fff] [ 0.047163] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.048705] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.049024] ... version: 2 [ 0.050012] ... bit width: 48 [ 0.051012] ... generic registers: 4 [ 0.052013] ... value mask: 0000ffffffffffff [ 0.053014] ... max period: 00007fffffffffff [ 0.054015] ... fixed-purpose events: 3 [ 0.055010] ... event mask: 000000070000000f [ 0.056272] rcu: Hierarchical SRCU implementation. [ 0.058441] smp: Bringing up secondary CPUs ... [ 0.059543] x86: Booting SMP configuration: [ 0.060023] .... node #0, CPUs: #1 #2 #3 [ 0.064013] smp: Brought up 1 node, 4 CPUs [ 0.066021] smpboot: Max logical packages: 1 [ 0.067016] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.143197] node 0 deferred pages initialised in 73ms [ 0.147209] devtmpfs: initialized [ 0.148223] x86/mm: Memory block size: 128MB [ 0.150754] gcov: version magic: 0x41383552 [ 0.151673] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.154079] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.156367] pinctrl core: initialized pinctrl subsystem [ 0.158187] [ 0.158816] ************************************************************* [ 0.161011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.162010] ** ** [ 0.164010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.166029] ** ** [ 0.168014] ** This means that this kernel is built to expose internal ** [ 0.170015] ** IOMMU data structures, which may compromise security on ** [ 0.172026] ** your system. ** [ 0.173010] ** ** [ 0.175012] ** If you see this message and you are not debugging the ** [ 0.177012] ** kernel, report this immediately to your vendor! ** [ 0.179018] ** ** [ 0.181012] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.183013] ************************************************************* [ 0.185724] NET: Registered protocol family 16 [ 0.188432] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.190039] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.192064] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.195102] cpuidle: using governor menu [ 0.197505] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.199635] PCI: Using configuration type 1 for base access [ 0.201132] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.212172] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.213028] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.216044] cryptd: max_cpu_qlen set to 1000 [ 0.219327] ACPI: Added _OSI(Module Device) [ 0.221008] ACPI: Added _OSI(Processor Device) [ 0.222014] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.223013] ACPI: Added _OSI(Processor Aggregator Device) [ 0.228385] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.234449] ACPI: Interpreter enabled [ 0.236144] ACPI: PM: (supports S0 S3 S4 S5) [ 0.238012] ACPI: Using IOAPIC for interrupt routing [ 0.239099] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.242497] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.252074] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.253049] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.255017] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.257175] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.263342] acpiphp: Slot [2] registered [ 0.264104] acpiphp: Slot [5] registered [ 0.265096] acpiphp: Slot [6] registered [ 0.266110] acpiphp: Slot [3] registered [ 0.268093] acpiphp: Slot [4] registered [ 0.269138] acpiphp: Slot [7] registered [ 0.271104] acpiphp: Slot [8] registered [ 0.272104] acpiphp: Slot [9] registered [ 0.273081] acpiphp: Slot [10] registered [ 0.275124] acpiphp: Slot [11] registered [ 0.276125] acpiphp: Slot [12] registered [ 0.278108] acpiphp: Slot [13] registered [ 0.279101] acpiphp: Slot [14] registered [ 0.280274] acpiphp: Slot [15] registered [ 0.282107] acpiphp: Slot [16] registered [ 0.283097] acpiphp: Slot [17] registered [ 0.285099] acpiphp: Slot [18] registered [ 0.286129] acpiphp: Slot [19] registered [ 0.288117] acpiphp: Slot [20] registered [ 0.289110] acpiphp: Slot [21] registered [ 0.290239] acpiphp: Slot [22] registered [ 0.292107] acpiphp: Slot [23] registered [ 0.293159] acpiphp: Slot [24] registered [ 0.294069] acpiphp: Slot [25] registered [ 0.295077] acpiphp: Slot [26] registered [ 0.297099] acpiphp: Slot [27] registered [ 0.298157] acpiphp: Slot [28] registered [ 0.300114] acpiphp: Slot [29] registered [ 0.302142] acpiphp: Slot [30] registered [ 0.303108] acpiphp: Slot [31] registered [ 0.305076] PCI host bridge to bus 0000:00 [ 0.306024] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.309026] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.311025] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.314024] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.316021] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.319027] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.320183] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.323649] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.327567] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.335585] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.338628] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.342025] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.344025] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.347020] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.349598] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.352802] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.356058] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.359510] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.362969] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.373920] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.378016] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.383149] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.387937] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.393021] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.406018] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.417282] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.424016] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.433019] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.459016] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.468154] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.471421] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.473515] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.475465] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.477362] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.482119] iommu: Default domain type: Passthrough [ 0.484567] SCSI subsystem initialized [ 0.486157] ACPI: bus type USB registered [ 0.487239] usbcore: registered new interface driver usbfs [ 0.490117] usbcore: registered new interface driver hub [ 0.492245] usbcore: registered new device driver usb [ 0.494189] pps_core: LinuxPPS API ver. 1 registered [ 0.495010] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.499122] PTP clock support registered [ 0.501034] EDAC MC: Ver: 3.0.0 [ 0.503160] PCI: Using ACPI for IRQ routing [ 0.504792] NetLabel: Initializing [ 0.506012] NetLabel: domain hash size = 128 [ 0.508008] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.509082] NetLabel: unlabeled traffic allowed by default [ 0.511137] vgaarb: loaded [ 0.513299] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.515010] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.521417] clocksource: Switched to clocksource kvm-clock [ 0.628593] VFS: Disk quotas dquot_6.6.0 [ 0.630377] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.632894] *** VALIDATE ramfs *** [ 0.634883] *** VALIDATE hugetlbfs *** [ 0.637406] pnp: PnP ACPI init [ 0.640165] pnp: PnP ACPI: found 6 devices [ 0.660372] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.664211] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.665984] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.668503] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.671275] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.673653] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.676645] NET: Registered protocol family 2 [ 0.679404] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.684607] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.688742] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.693765] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.696844] TCP: Hash tables configured (established 65536 bind 65536) [ 0.699172] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.702428] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.704803] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.708595] NET: Registered protocol family 1 [ 0.711565] RPC: Registered named UNIX socket transport module. [ 0.713940] RPC: Registered udp transport module. [ 0.715680] RPC: Registered tcp transport module. [ 0.717327] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.719679] NET: Registered protocol family 44 [ 0.721340] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.723599] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.725535] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.727939] PCI: CLS 0 bytes, default 64 [ 0.729247] Unpacking initramfs... [ 2.152563] debug: unmapping init [mem 0xffff8d8a3cc64000-0xffff8d8a3ffcffff] [ 2.155550] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.157276] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.159253] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.662871] Initialise system trusted keyrings [ 2.664573] Key type blacklist registered [ 2.667071] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.676245] zbud: loaded [ 2.679722] *** VALIDATE nfs *** [ 2.680929] *** VALIDATE nfs4 *** [ 2.682679] pstore: using deflate compression [ 2.686118] Platform Keyring initialized [ 2.793116] NET: Registered protocol family 38 [ 2.795219] Key type asymmetric registered [ 2.796881] Asymmetric key parser 'x509' registered [ 2.799091] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.803150] io scheduler mq-deadline registered [ 2.804501] io scheduler kyber registered [ 2.806153] io scheduler bfq registered [ 2.807698] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.810404] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.812883] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.815341] ACPI: Power Button [PWRF] [ 2.820700] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.826535] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.840162] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.867156] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.895017] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.900636] Non-volatile memory driver v1.3 [ 2.902259] Linux agpgart interface v0.103 [ 2.934131] virtio_blk virtio1: [vda] 146624 512-byte logical blocks (75.1 MB/71.6 MiB) [ 2.936567] vda: detected capacity change from 0 to 75071488 [ 2.954826] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.958578] vdb: detected capacity change from 0 to 1073741824 [ 2.966898] libphy: Fixed MDIO Bus: probed [ 2.974536] usbcore: registered new interface driver usbserial_generic [ 2.977708] usbserial: USB Serial support registered for generic [ 2.980432] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.985133] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.987026] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.989573] mousedev: PS/2 mouse device common for all mice [ 2.993094] rtc_cmos 00:05: RTC can wake from S4 [ 2.996334] rtc_cmos 00:05: registered as rtc0 [ 2.997038] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.998452] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.004424] intel_pstate: CPU model not supported [ 3.007194] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.008838] hid: raw HID events driver (C) Jiri Kosina [ 3.012725] usbcore: registered new interface driver usbhid [ 3.014387] usbhid: USB HID core driver [ 3.015786] drop_monitor: Initializing network drop monitor service [ 3.015796] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.017614] Initializing XFRM netlink socket [ 3.022474] NET: Registered protocol family 10 [ 3.025114] Segment Routing with IPv6 [ 3.026983] NET: Registered protocol family 17 [ 3.029907] mpls_gso: MPLS GSO support [ 3.035398] RAS: Correctable Errors collector initialized. [ 3.038227] AVX version of gcm_enc/dec engaged. [ 3.040132] AES CTR mode by8 optimization enabled [ 3.119140] sched_clock: Marking stable (3119093862, 0)->(4036370642, -917276780) [ 3.121739] registered taskstats version 1 [ 3.123641] Loading compiled-in X.509 certificates [ 3.125420] zswap: loaded using pool lzo/zbud [ 3.154464] Key type big_key registered [ 3.168335] Key type encrypted registered [ 3.170152] ima: No TPM chip found, activating TPM-bypass! [ 3.172326] ima: Allocated hash algorithm: sha1 [ 3.173969] ima: No architecture policies found [ 3.175352] evm: Initialising EVM extended attributes: [ 3.177910] evm: security.selinux [ 3.179285] evm: security.ima [ 3.180463] evm: security.capability [ 3.181980] evm: HMAC attrs: 0x1 [ 3.184308] rtc_cmos 00:05: setting system clock to 2026-08-27 11:35:27 UTC (1787830527) [ 3.190668] debug: unmapping init [mem 0xffffffffb4a03000-0xffffffffb4bfffff] [ 3.193884] debug: unmapping init [mem 0xffffffffb3782000-0xffffffffb3a58fff] [ 3.202147] Write protecting the kernel read-only data: 28672k [ 3.205076] debug: unmapping init [mem 0xffffffffb1e03000-0xffffffffb1ffffff] [ 3.207886] debug: unmapping init [mem 0xffffffffb2714000-0xffffffffb27fffff] [ 3.239883] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 3.253682] systemd[1]: Detected virtualization kvm. [ 3.256204] systemd[1]: Detected architecture x86-64. [ 3.258687] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.286654] systemd[1]: No hostname configured. [ 3.289039] systemd[1]: Set hostname to . [ 3.291413] random: systemd: uninitialized urandom read (16 bytes read) [ 3.294543] systemd[1]: Initializing machine ID from random generator. [ 3.357653] random: ln: uninitialized urandom read (6 bytes read) [ 3.456205] random: systemd: uninitialized urandom read (16 bytes read) [ 3.460311] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 3.465338] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 3.470811] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Started Memstrack Anylazing Service. Starting Apply Kernel Variables... [ OK ] Listening on Journal Socket (/dev/log). Starting Journal Service... [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target Slices. Starting Setup Virtual Console... [ OK ] Reached target Swap. [ OK ] Reached target Timers. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target Paths. [ OK ] Reached target Sockets. [ OK ] Reached target Initrd Root Device. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Setup Virtual Console. Starting dracut cmdline hook... Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.192328] device-mapper: uevent: version 1.0.3 [ 4.194599] device-mapper: ioctl: 4.46.0-ioctl (2022-02-22) initialised: dm-devel@redhat.com [ OK ] Started dracut pre-udev hook. Starting udev Kernel Device Manager... [ OK ] Started udev Kernel Device Manager. Starting dracut pre-trigger hook... [ OK ] Started dracut pre-trigger hook. Starting udev Coldplug all Devices... Mounting Kernel Configuration File System... [ OK ] Mounted Kernel Configuration File System. [ OK ] Started udev Coldplug all Devices. Starting dracut initqueue hook... [ OK ] Reached target System Initialization. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ 5.063785] virtio_net virtio0 ens2: renamed from eth0 [ 5.146580] scsi host0: ata_piix [ 5.216444] scsi host1: ata_piix [ 5.221285] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.223911] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 9.613293] dracut-initqueue[590]: RTNETLINK answers: File exists [ 9.687236] random: crng init done [ 9.688345] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Mounting /sysroot... [ 10.229718] 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 Initrd Default Target. [ OK ] Stopped target Timers. [ OK ] Stopped target Initrd Root Device. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped target Swap. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped target Local File Systems. Stopping udev Kernel Device Manager... [ OK ] Stopped Apply Kernel Variables. [ 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... [ 11.489529] printk: systemd: 25 output lines suppressed due to ratelimiting [ 11.754117] SELinux: Disabled at runtime. [ 11.817149] systemd[1]: systemd 239 (239-82.el8_10.5) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy) [ 11.826066] systemd[1]: Detected virtualization kvm. [ 11.827814] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.364606] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.369776] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.377271] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.383365] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.388775] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.398986] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.406874] systemd[1]: Created slice system-sshd\x2dkeygen.slice. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Kernel Socket. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Mounting Kernel Debug File System... Starting Remount Root and Kernel File Systems... [ OK ] Started Forward Password Requests to Wall Directory Watch. Mounting POSIX Message Queue File System... Mounting Huge Pages File System... [ OK ] Listening on udev Control Socket. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Reached target rpc_pipefs.target. [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd Root File System. [ OK ] Stopped target Initrd File Systems. [ OK ] Reached target Paths. Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Starting Apply Kernel Variables... Starting udev Coldplug all Devices... Activating swap /dev/disk/by-label/SWAP... [ OK ] Created slice system-getty.slice. [ OK ] Started Journal Service. [ 12.612756] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Mounted Kernel Debug File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Reached target Swap. Starting Create Static Device Nodes in /dev... Starting Configure read-only root support... Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ OK ] Mounted /mnt. [ 12.867235] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Coldplug all Devices. [ OK ] Started udev Kernel Device Manager. [ 13.214842] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 13.258245] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.329670] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 13.359335] EDAC sbridge: Ver: 1.1.2 [ 14.606847] Key type dns_resolver registered [ 14.912223] NFS: Registering the id_resolver key type [ 14.914388] Key type id_resolver registered [ 14.915926] Key type id_legacy registered [ 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 ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. Starting Login Service... [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. Starting Network Manager Wait Online... [ OK ] Reached target Network. Starting OpenSSH server daemon... Starting Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... 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 Command Scheduler. [ OK ] Started Getty on tty1. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Hostname Service. Starting Network Manager Script Dispatcher Service... [ OK ] Started Network Manager Script Dispatcher Service. [ OK ] Started Network Manager Wait Online. [ OK ] Reached target Network is Online. Starting Notify NFS peers of a restart... Starting System Logging Service... Starting Crash recovery kernel arming... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg420-client login: [ 37.113053] hrtimer: interrupt took 7040931 ns [ 91.197862] libcfs: loading out-of-tree module taints kernel. [ 91.567565] Key type ._llcrypt registered [ 91.609759] Key type .llcrypt registered [ 92.471536] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 92.514592] alg: No test for adler32 (adler32-zlib) [ 94.686374] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 96.335821] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 98.240262] Key type lgssc registered [ 100.912701] Lustre: Echo OBD driver; http://www.lustre.org/ [ 289.746712] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 295.263988] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 308.935685] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing check_logdir /tmp/testlogs/ [ 314.081858] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing yml_node [ 315.364718] Lustre: lustre-OST0000-osc-ffff8d8a83c2c000: disconnect after 23s idle [ 319.049752] Lustre: DEBUG MARKER: Client: 2.17.57.61 [ 322.361817] Lustre: DEBUG MARKER: MDS: 2.17.57.61 [ 325.016856] Lustre: DEBUG MARKER: OSS: 2.17.57.61 [ 327.462123] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Aug 27 07:40:49 EDT 2026 [ 347.074687] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 348.818304] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 351.185837] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 361.588306] Lustre: Unmounted lustre-client [ 476.686821] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 484.352752] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 508.001171] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 549.463490] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 07:44:31 (1787831071) [ 552.033157] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 554.007943] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 07:44:36 (1787831076) [ 586.236856] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 592.374980] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 613.143304] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 613.694332] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 618.841951] Lustre: Unmounted lustre-client [ 645.944337] Key type lgssc unregistered [ 646.198318] LNet: 15033:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 646.207442] LNetError: 15033:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 646.220627] LNet: Removed LNI 192.168.204.20@tcp [ 646.978197] Key type .llcrypt unregistered [ 646.990790] Key type ._llcrypt unregistered [ 664.227056] Key type ._llcrypt registered [ 664.230403] Key type .llcrypt registered [ 665.574344] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 07:46:28 (1787831188) [ 667.431115] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 667.528894] alg: No test for adler32 (adler32-zlib) [ 668.687741] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 669.080505] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 670.832216] Key type lgssc registered [ 672.304709] Lustre: Echo OBD driver; http://www.lustre.org/ [ 749.235749] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 835.754680] Lustre: Unmounted lustre-client [ 868.488079] Key type lgssc unregistered [ 868.883096] LNet: 18850:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 868.900935] LNetError: 18850:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 869.929072] LNet: Removed LNI 192.168.204.20@tcp [ 870.859202] Key type .llcrypt unregistered [ 870.861498] Key type ._llcrypt unregistered [ 883.162906] Key type ._llcrypt registered [ 883.166588] Key type .llcrypt registered [ 885.092270] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 07:50:07 (1787831407) [ 887.668319] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 887.697381] alg: No test for adler32 (adler32-zlib) [ 889.034540] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 889.357776] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 891.089886] Key type lgssc registered [ 892.906918] Lustre: Echo OBD driver; http://www.lustre.org/ [ 947.603032] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 954.018914] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 977.455434] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 980.400839] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 992.046240] Lustre: Unmounted lustre-client [ 1026.306686] Key type lgssc unregistered [ 1026.787190] LNet: 22453:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1026.796443] LNetError: 22453:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1026.815501] LNet: Removed LNI 192.168.204.20@tcp [ 1027.857295] Key type .llcrypt unregistered [ 1027.862131] Key type ._llcrypt unregistered [ 1040.665194] Key type ._llcrypt registered [ 1040.667745] Key type .llcrypt registered [ 1042.482757] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 07:52:44 (1787831564) [ 1045.091975] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1045.238065] alg: No test for adler32 (adler32-zlib) [ 1046.416323] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 1046.831574] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 1048.704214] Key type lgssc registered [ 1050.476305] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1110.988173] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1117.921308] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1144.256542] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1147.266100] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 1155.243757] Lustre: Unmounted lustre-client [ 1186.425276] Key type lgssc unregistered [ 1186.791387] LNet: 25645:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1186.802434] LNetError: 25645:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1186.839243] LNet: Removed LNI 192.168.204.20@tcp [ 1187.734830] Key type .llcrypt unregistered [ 1187.738789] Key type ._llcrypt unregistered [ 1205.739714] Key type ._llcrypt registered [ 1205.743510] Key type .llcrypt registered [ 1207.162521] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 07:55:29 (1787831729) [ 1210.089034] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1210.129966] alg: No test for adler32 (adler32-zlib) [ 1211.267377] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 1211.581402] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 1213.288181] Key type lgssc registered [ 1214.820823] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1270.715318] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1277.623429] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1302.732894] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1313.879953] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 1324.015635] Lustre: lustre-MDT0000-mdc-ffff8d8a867a5800: Connection to lustre-MDT0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1334.260407] Lustre: lustre-MDT0001-mdc-ffff8d8a867a5800: Connection to lustre-MDT0001 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1338.092170] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1345.504256] Lustre: 26604:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787831853/real 1787831853] req@0000000080f29ff2 x1874677449366016/t0(0) o400->MGC192.168.204.120@tcp@192.168.204.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1787831869 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1345.537306] LustreError: MGC192.168.204.120@tcp: Connection to MGS (at 192.168.204.120@tcp) was lost; in progress operations using this service will fail [ 1348.473914] Lustre: Unmounted lustre-client [ 1368.988900] Key type lgssc unregistered [ 1369.287919] LNet: 29303:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1369.294650] LNetError: 29303:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1369.338932] LNet: Removed LNI 192.168.204.20@tcp [ 1370.213822] Key type .llcrypt unregistered [ 1370.222403] Key type ._llcrypt unregistered [ 1388.667840] Key type ._llcrypt registered [ 1388.669925] Key type .llcrypt registered [ 1390.099206] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 07:58:32 (1787831912) [ 1392.243251] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1392.326706] alg: No test for adler32 (adler32-zlib) [ 1393.413182] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 1393.659541] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 1395.376230] Key type lgssc registered [ 1397.017134] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1457.497232] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1464.721821] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1488.951750] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1496.117610] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 1501.165445] Lustre: lustre-OST0000-osc-ffff8d8a85c9f800: Connection to lustre-OST0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1508.970168] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1519.351552] Lustre: Unmounted lustre-client [ 1548.395524] Key type lgssc unregistered [ 1548.622644] LNet: 32929:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1548.628916] LNetError: 32929:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1548.688170] LNet: Removed LNI 192.168.204.20@tcp [ 1549.695395] Key type .llcrypt unregistered [ 1549.697936] Key type ._llcrypt unregistered [ 1568.562189] Key type ._llcrypt registered [ 1568.563932] Key type .llcrypt registered [ 1570.024201] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 08:01:32 (1787832092) [ 1572.808145] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1572.819925] alg: No test for adler32 (adler32-zlib) [ 1573.890277] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 1574.257565] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 1576.048510] Key type lgssc registered [ 1578.262786] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1637.074247] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1644.328414] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1672.338759] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1678.963342] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 1683.694767] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1689.842837] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1702.067734] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-08-27 8h03m44s [ 1704.718395] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1709.573060] Lustre: lustre-MDT0000-mdc-ffff8d8a82e24800: Connection to lustre-MDT0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1724.320790] LustreError: 36722:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff8d8a82e24800: can't stat MDS #0: rc = -19 [ 1726.417250] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1735.146276] LustreError: MGC192.168.204.120@tcp: Connection to MGS (at 192.168.204.120@tcp) was lost; in progress operations using this service will fail [ 1735.183559] Lustre: Evicted from MGS (at 192.168.204.120@tcp) after server handle changed from 0x858c4460168ef822 to 0x858c4460168efaad [ 1735.205356] Lustre: MGC192.168.204.120@tcp: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [ 1740.308441] LustreError: lustre-MDT0000-mdc-ffff8d8a82e24800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1740.342400] Lustre: lustre-MDT0000-mdc-ffff8d8a82e24800: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [ 1745.268826] Lustre: DEBUG MARKER: Wait for df (36722) ... [ 1747.690456] Lustre: DEBUG MARKER: done [ 1750.582691] Lustre: Unmounted lustre-client [ 1780.755918] Key type lgssc unregistered [ 1781.189143] LNet: 37744:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1781.207591] LNetError: 37744:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1781.225468] LNet: Removed LNI 192.168.204.20@tcp [ 1782.074570] Key type .llcrypt unregistered [ 1782.079830] Key type ._llcrypt unregistered [ 1817.973247] Key type ._llcrypt registered [ 1817.975387] Key type .llcrypt registered [ 1820.276700] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 08:05:42 (1787832342) [ 1823.496875] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1823.658621] alg: No test for adler32 (adler32-zlib) [ 1825.119844] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 1825.586670] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 1827.352592] Key type lgssc registered [ 1828.705958] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1885.341450] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1892.703274] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1917.777652] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1919.599798] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 1925.343954] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-08-27 8h07m27s [ 1927.407279] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1936.250260] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1939.933873] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1960.418624] Lustre: 41890:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787832464/real 1787832464] req@0000000025bb675c x1874678093192320/t0(0) o101->lustre-MDT0000-mdc-ffff8d8aa0313000@192.168.204.120@tcp:12/10 lens 576/1152 e 0 to 1 dl 1787832484 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1960.456677] Lustre: lustre-MDT0000-mdc-ffff8d8aa0313000: Connection to lustre-MDT0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1960.493909] Lustre: lustre-MDT0000-mdc-ffff8d8aa0313000: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [ 1982.047571] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1986.197659] Lustre: DEBUG MARKER: done [ 1991.765484] Lustre: Unmounted lustre-client [ 2023.339734] Key type lgssc unregistered [ 2023.860287] LNet: 42780:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2023.879627] LNetError: 42780:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2024.940891] LNet: Removed LNI 192.168.204.20@tcp [ 2026.339444] Key type .llcrypt unregistered [ 2026.342802] Key type ._llcrypt unregistered [ 2066.025704] Key type ._llcrypt registered [ 2066.027909] Key type .llcrypt registered [ 2067.805431] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 08:09:50 (1787832590) [ 2070.219793] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 2073.452520] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 08:09:54 (1787832594) [ 2078.694641] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2078.731064] alg: No test for adler32 (adler32-zlib) [ 2080.104700] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 2080.519625] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 2082.248208] Key type lgssc registered [ 2083.610940] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2123.478872] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 08:10:45 (1787832645) [ 2162.812787] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2170.044243] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2196.013395] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2198.770628] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 2202.810802] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2208.116262] Lustre: Unmounted lustre-client [ 2225.213926] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2274.974555] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2281.450510] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2282.529232] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 2288.248125] Lustre: Unmounted lustre-client [ 2354.698620] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2362.334919] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2363.314342] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 2368.354327] Lustre: Unmounted lustre-client [ 2396.552357] Lustre: DEBUG MARKER: files compared the same [ 2423.548858] Key type lgssc unregistered [ 2423.857936] LNet: 50416:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2423.868031] LNetError: 50416:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2423.902313] LNet: Removed LNI 192.168.204.20@tcp [ 2424.886354] Key type .llcrypt unregistered [ 2424.890096] Key type ._llcrypt unregistered [ 2442.131626] Key type ._llcrypt registered [ 2442.136971] Key type .llcrypt registered [ 2443.486253] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 08:16:06 (1787832966) [ 2446.428133] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2446.461742] alg: No test for adler32 (adler32-zlib) [ 2447.647839] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 2447.944196] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 2449.747250] Key type lgssc registered [ 2451.737316] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2511.774631] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2519.373483] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2547.648728] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2554.993138] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 2560.218200] Lustre: Unmounted lustre-client [ 2590.110440] Key type lgssc unregistered [ 2590.375155] LNet: 54011:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2590.386977] LNetError: 54011:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2590.409929] LNet: Removed LNI 192.168.204.20@tcp [ 2591.171180] Key type .llcrypt unregistered [ 2591.175240] Key type ._llcrypt unregistered [ 2608.466255] Key type ._llcrypt registered [ 2608.477140] Key type .llcrypt registered [ 2610.021487] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 08:18:52 (1787833132) [ 2612.464298] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2612.486070] alg: No test for adler32 (adler32-zlib) [ 2613.535897] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 2613.793835] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 2615.472205] Key type lgssc registered [ 2616.656721] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2703.757773] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2741.721808] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2748.823744] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2777.667956] Key type lgssc unregistered [ 2777.980845] LNet: 57501:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2777.989374] LNetError: 57501:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2778.001855] LNet: Removed LNI 192.168.204.20@tcp [ 2778.520285] Key type .llcrypt unregistered [ 2778.523098] Key type ._llcrypt unregistered [ 2795.671286] Key type ._llcrypt registered [ 2795.673900] Key type .llcrypt registered [ 2797.198959] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 08:21:59 (1787833319) [ 2801.151693] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2801.190677] alg: No test for adler32 (adler32-zlib) [ 2802.434300] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 2802.792509] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 2804.624242] Key type lgssc registered [ 2806.345342] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2893.724902] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 2902.135539] Lustre: Unmounted lustre-client [ 2941.820850] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 08:24:24 (1787833464) [ 3074.889976] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3098.748093] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 3106.973242] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 3106.999912] LustreError: 63976:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff8d8a867a4000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 3107.071436] Lustre: 58488:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.204.120@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 3117.457820] Lustre: Unmounted lustre-client [ 3167.594957] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 08:28:09 (1787833689) [ 3180.990071] Key type lgssc unregistered [ 3181.264257] LNet: 65191:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3181.270672] LNetError: 65191:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3181.285930] LNet: Removed LNI 192.168.204.20@tcp [ 3182.164588] Key type .llcrypt unregistered [ 3182.174482] Key type ._llcrypt unregistered [ 3197.546409] Key type ._llcrypt registered [ 3197.548697] Key type .llcrypt registered [ 3198.425564] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3198.459553] alg: No test for adler32 (adler32-zlib) [ 3199.695933] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 3200.020414] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 3201.825299] Key type lgssc registered [ 3203.714879] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3262.109566] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3268.221085] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3290.103969] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3291.880169] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 3299.569784] Lustre: Unmounted lustre-client [ 3328.273379] Key type lgssc unregistered [ 3328.542838] LNet: 68209:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3328.551132] LNetError: 68209:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3328.575620] LNet: Removed LNI 192.168.204.20@tcp [ 3329.365454] Key type .llcrypt unregistered [ 3329.372811] Key type ._llcrypt unregistered [ 3339.678788] Key type ._llcrypt registered [ 3339.685351] Key type .llcrypt registered [ 3340.154487] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3340.204668] alg: No test for adler32 (adler32-zlib) [ 3341.224432] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 3341.420214] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 3343.128301] Key type lgssc registered [ 3344.675605] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3462.270675] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3467.348294] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3488.518953] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3491.324331] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 3495.082143] Lustre: Unmounted lustre-client [ 3523.984283] Key type lgssc unregistered [ 3524.288732] LNet: 71640:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3524.301105] LNetError: 71640:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3524.320604] LNet: Removed LNI 192.168.204.20@tcp [ 3525.234067] Key type .llcrypt unregistered [ 3525.237950] Key type ._llcrypt unregistered [ 3543.359549] Key type ._llcrypt registered [ 3543.366126] Key type .llcrypt registered [ 3544.983779] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 08:34:27 (1787834067) [ 3547.643514] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3547.772614] alg: No test for adler32 (adler32-zlib) [ 3548.833218] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 3549.036627] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 3550.728206] Key type lgssc registered [ 3552.304498] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3610.908027] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3618.688275] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3647.397447] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3654.802908] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 3661.869224] Lustre: Unmounted lustre-client [ 3662.401764] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 3666.534446] Lustre: Unmounted lustre-client [ 3701.045173] Key type lgssc unregistered [ 3701.381930] LNet: 75338:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3701.388583] LNetError: 75338:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3701.410574] LNet: Removed LNI 192.168.204.20@tcp [ 3702.034164] Key type .llcrypt unregistered [ 3702.036551] Key type ._llcrypt unregistered [ 3714.753906] Key type ._llcrypt registered [ 3714.758754] Key type .llcrypt registered [ 3715.423618] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3715.451351] alg: No test for adler32 (adler32-zlib) [ 3716.717909] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 3717.015790] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 3718.792629] Key type lgssc registered [ 3720.226886] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3782.490508] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3790.482315] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3817.546066] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3820.091325] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 3824.374929] Lustre: Unmounted lustre-client [ 3856.635370] Key type lgssc unregistered [ 3857.051844] LNet: 78377:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3857.072790] LNetError: 78377:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3857.109677] LNet: Removed LNI 192.168.204.20@tcp [ 3858.025702] Key type .llcrypt unregistered [ 3858.042285] Key type ._llcrypt unregistered [ 3882.249149] Key type ._llcrypt registered [ 3882.264842] Key type .llcrypt registered [ 3884.099958] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 08:40:06 (1787834406) [ 3887.449880] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3887.539366] alg: No test for adler32 (adler32-zlib) [ 3888.741984] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 3889.144192] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 3890.856366] Key type lgssc registered [ 3892.100071] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3959.877099] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3967.135995] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3993.434614] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3996.028811] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 4001.870323] Lustre: lustre: root_squash is set to 0:0 [ 4008.965065] Lustre: lustre: nosquash_nids is cleared [ 4017.199883] Lustre: lustre: root_squash is set to 500:500 [ 4027.046985] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.204.20@tcp 192.168.0.[2,10]@tcp [ 4037.133730] Lustre: lustre: nosquash_nids set to 192.168.204.20/24@tcp [ 4043.534702] Lustre: Unmounted lustre-client [ 4081.719398] Key type lgssc unregistered [ 4082.036626] LNet: 82347:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4082.048650] LNetError: 82347:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4082.072393] LNet: Removed LNI 192.168.204.20@tcp [ 4082.719949] Key type .llcrypt unregistered [ 4082.723066] Key type ._llcrypt unregistered [ 4101.797761] Key type ._llcrypt registered [ 4101.801529] Key type .llcrypt registered [ 4103.772601] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 08:43:45 (1787834625) [ 4106.611331] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 4109.323609] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 08:43:51 (1787834631) [ 4112.007572] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4112.124321] alg: No test for adler32 (adler32-zlib) [ 4113.376685] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 4113.641513] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 4115.416209] Key type lgssc registered [ 4116.860104] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4176.353128] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4181.816424] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4204.886307] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4206.658320] Lustre: lustre: root_squash is set to 500:500 [ 4206.692544] Lustre: lustre: nosquash_nids set to 192.168.204.20/24@tcp [ 4207.867352] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 4213.791830] Lustre: Unmounted lustre-client [ 4251.962575] Key type lgssc unregistered [ 4252.223214] LNet: 86310:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4252.227506] LNetError: 86310:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4252.271460] LNet: Removed LNI 192.168.204.20@tcp [ 4253.068403] Key type .llcrypt unregistered [ 4253.070429] Key type ._llcrypt unregistered [ 4269.454893] Key type ._llcrypt registered [ 4269.460911] Key type .llcrypt registered [ 4271.036676] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 4272.787177] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 08:46:35 (1787834795) [ 4295.468225] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4295.494666] alg: No test for adler32 (adler32-zlib) [ 4296.659639] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 4297.037489] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 4298.776398] Key type lgssc registered [ 4300.060959] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4394.583477] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4401.125776] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4425.912458] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4499.076229] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4505.476244] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4528.771967] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4548.012990] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 4583.667484] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8d8aa00ea800.ost_server_uuid 50 [ 4585.777293] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8d8aa00ea800.ost_server_uuid in IDLE state after 0 sec [ 4586.385720] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 4591.573603] Lustre: Unmounted lustre-client [ 4594.343236] Lustre: Unmounted lustre-client [ 4643.495588] Key type lgssc unregistered [ 4643.876632] LNet: 93978:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4643.887617] LNetError: 93978:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4643.904995] LNet: Removed LNI 192.168.204.20@tcp [ 4644.639237] Key type .llcrypt unregistered [ 4644.643369] Key type ._llcrypt unregistered [ 4682.096863] Key type ._llcrypt registered [ 4682.099699] Key type .llcrypt registered [ 4684.087166] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 08:53:26 (1787835206) [ 4705.952789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4706.031067] alg: No test for adler32 (adler32-zlib) [ 4707.192078] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 4707.458420] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 4709.137521] Key type lgssc registered [ 4710.453991] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4801.018141] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4807.789925] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4833.595747] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4836.784088] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 4858.272218] Lustre: 95340:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787835366/real 1787835366] req@000000008a8fe6b9 x1874681115186432/t0(0) o400->lustre-OST0000-osc-ffff8d8a867a7800@192.168.204.120@tcp:28/4 lens 224/224 e 0 to 1 dl 1787835382 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4858.320521] Lustre: lustre-OST0000-osc-ffff8d8a867a7800: Connection to lustre-OST0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4861.408330] Lustre: 95339:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787835369/real 1787835369] req@0000000019d5dc23 x1874681115186944/t0(0) o400->lustre-OST0000-osc-ffff8d8a867a7800@192.168.204.120@tcp:28/4 lens 224/224 e 0 to 1 dl 1787835385 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4865.824232] Lustre: 95340:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787835374/real 1787835374] req@000000000809194f x1874681115187456/t0(0) o400->lustre-OST0000-osc-ffff8d8a867a7800@192.168.204.120@tcp:28/4 lens 224/224 e 0 to 1 dl 1787835390 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4868.686447] Lustre: lustre-OST0000-osc-ffff8d8a867a7800: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [ 4871.648261] Lustre: 95339:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787835379/real 1787835379] req@0000000061c0fd8a x1874681115187968/t0(0) o400->lustre-OST0000-osc-ffff8d8a867a7800@192.168.204.120@tcp:28/4 lens 224/224 e 0 to 1 dl 1787835395 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4873.706074] Lustre: lustre-MDT0000-mdc-ffff8d8a867a7800: Connection to lustre-MDT0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4890.081837] Lustre: 95339:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787835398/real 1787835398] req@0000000035df2afd x1874681115190144/t0(0) o400->MGC192.168.204.120@tcp@192.168.204.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1787835414 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4890.132828] LustreError: MGC192.168.204.120@tcp: Connection to MGS (at 192.168.204.120@tcp) was lost; in progress operations using this service will fail [ 4900.341146] Lustre: Evicted from MGS (at 192.168.204.120@tcp) after server handle changed from 0x491690ebf78fd907 to 0x491690ebf78fda9d [ 4900.358350] Lustre: MGC192.168.204.120@tcp: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [ 4907.653620] Lustre: lustre-MDT0000-mdc-ffff8d8a867a7800: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [ 4912.920184] Lustre: Unmounted lustre-client [ 4940.245767] Key type lgssc unregistered [ 4940.531438] LNet: 99648:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4940.542039] LNetError: 99648:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4940.573693] LNet: Removed LNI 192.168.204.20@tcp [ 4941.302105] Key type .llcrypt unregistered [ 4941.306449] Key type ._llcrypt unregistered [ 4957.637487] Key type ._llcrypt registered [ 4957.643022] Key type .llcrypt registered [ 4958.979168] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 08:58:01 (1787835481) [ 4973.743049] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4973.760345] alg: No test for adler32 (adler32-zlib) [ 4974.772928] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 4974.990950] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 4976.672263] Key type lgssc registered [ 4977.819348] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5017.356743] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5123.600577] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5129.960397] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5153.286932] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5154.883369] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 5157.155306] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 5158.855407] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 09:01:21 (1787835681) [ 5426.113551] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5436.465054] Lustre: Unmounted lustre-client [ 5578.440916] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5585.677540] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5613.320719] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5662.553208] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 09:09:44 (1787836184) [ 5768.287457] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5777.008426] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5810.423092] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5811.371918] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 5816.804308] Lustre: Unmounted lustre-client [ 5858.122811] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 09:13:00 (1787836380) [ 5967.084966] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5973.840969] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6001.906174] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6002.780616] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 6008.476220] Lustre: Unmounted lustre-client [ 6039.257842] Key type lgssc unregistered [ 6039.662566] LNet: 122722:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6039.671863] LNetError: 122722:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6039.698178] LNet: Removed LNI 192.168.204.20@tcp [ 6040.775150] Key type .llcrypt unregistered [ 6040.777647] Key type ._llcrypt unregistered [ 6059.564186] Key type ._llcrypt registered [ 6059.569585] Key type .llcrypt registered [ 6061.644641] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 09:16:23 (1787836583) [ 6065.688510] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6065.754021] alg: No test for adler32 (adler32-zlib) [ 6066.942251] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 6067.271763] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 6069.024481] Key type lgssc registered [ 6070.326348] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6140.401480] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6148.919951] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6177.398721] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6180.101722] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 6194.346649] Lustre: Unmounted lustre-client [ 6233.386263] Key type lgssc unregistered [ 6233.750522] LNet: 126325:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6233.762701] LNetError: 126325:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6233.779753] LNet: Removed LNI 192.168.204.20@tcp [ 6234.784250] Key type .llcrypt unregistered [ 6234.787138] Key type ._llcrypt unregistered [ 6256.355991] Key type ._llcrypt registered [ 6256.358172] Key type .llcrypt registered [ 6257.863306] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 09:19:40 (1787836780) [ 6260.686865] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6260.732210] alg: No test for adler32 (adler32-zlib) [ 6261.868233] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 6262.094940] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 6263.776172] Key type lgssc registered [ 6265.523251] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6317.518943] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6324.054775] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6347.960288] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6350.851687] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 6355.955942] Lustre: lustre-OST0000-osc-ffff8d8a87962000: Connection to lustre-OST0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6369.309910] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff8d8a87962000.ost_server_uuid 50 [ 6371.121278] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 6382.595329] Lustre: Unmounted lustre-client [ 6407.725504] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 09:22:09 (1787836929) [ 6447.119750] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6453.336833] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6476.924936] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6504.547722] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6505.776634] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 6511.091422] Lustre: lustre-OST0000-osc-ffff8d8a867a4000: Connection to lustre-OST0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6547.739323] Lustre: Unmounted lustre-client [ 6599.765802] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 09:25:22 (1787837122) [ 6639.605623] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6646.221480] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6669.678141] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6696.011610] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6696.874493] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 6702.074469] Lustre: lustre-OST0000-osc-ffff8d8a91205000: Connection to lustre-OST0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6719.991113] Lustre: Unmounted lustre-client [ 6772.451644] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 09:28:15 (1787837295) [ 6881.765513] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6890.236639] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6917.978363] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6994.813841] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7002.232768] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7026.511410] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7063.558913] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 7111.480243] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7113.779603] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7117.187733] Lustre: Unmounted lustre-client [ 7160.910357] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 09:34:43 (1787837683) [ 7201.137417] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7209.150357] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7232.161882] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7270.735532] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7305.108248] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 7354.710726] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7357.623659] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7367.895949] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7378.218844] Lustre: Unmounted lustre-client [ 7448.337385] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 09:39:30 (1787837970) [ 7487.411168] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7494.487653] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7521.054478] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7522.136731] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 7550.672698] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7552.599689] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7572.660593] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff8d8a86eef000.ost_server_uuid 50 [ 7574.697094] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff8d8a86eef000.ost_server_uuid in IDLE state after 0 sec [ 7578.413854] Lustre: Unmounted lustre-client [ 7578.906821] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 7578.914853] Lustre: Skipped 3 previous similar messages [ 7579.064919] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 7580.647191] LustreError: 149751:0:(sec.c:403:import_sec_validate_get()) import 000000009d1ed987 (NEW) with no sec [ 7655.791699] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 09:42:58 (1787838178) [ 7698.147189] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7705.221180] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7732.414505] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7759.747900] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7760.639108] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7760.853579] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 7776.846394] Lustre: Unmounted lustre-client [ 7776.850770] Lustre: Skipped 1 previous similar message [ 7818.551636] Key type lgssc unregistered [ 7818.911285] LNet: 153176:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7818.926160] LNetError: 153176:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7818.955343] LNet: Removed LNI 192.168.204.20@tcp [ 7819.986748] Key type .llcrypt unregistered [ 7819.992542] Key type ._llcrypt unregistered [ 7838.505597] Key type ._llcrypt registered [ 7838.509569] Key type .llcrypt registered [ 7840.329300] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 09:46:02 (1787838362) [ 7841.998121] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7842.066966] alg: No test for adler32 (adler32-zlib) [ 7843.302232] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 7843.682427] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 7845.432430] Key type lgssc registered [ 7846.703175] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7903.748177] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7910.359880] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7933.428651] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7956.866426] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7958.576671] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7959.754558] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 7967.261559] LustreError: lustre-MDT0001-mdc-ffff8d8aa00ee800: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7967.294248] Lustre: lustre-MDT0001-mdc-ffff8d8aa00ee800: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [ 7974.988645] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7977.365773] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7998.506395] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 8002.198527] Lustre: Unmounted lustre-client [ 8031.658970] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 09:49:14 (1787838554) [ 8139.145624] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8145.703956] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8172.564234] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8173.303620] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 8203.768057] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8206.070480] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 8220.719754] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 8231.126675] Lustre: Unmounted lustre-client [ 8268.072323] Key type lgssc unregistered [ 8268.356783] LNet: 162797:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8268.388651] LNetError: 162797:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8268.421188] LNet: Removed LNI 192.168.204.20@tcp [ 8269.168282] Key type .llcrypt unregistered [ 8269.173431] Key type ._llcrypt unregistered [ 8305.707289] Key type ._llcrypt registered [ 8305.713118] Key type .llcrypt registered [ 8307.421766] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 09:53:49 (1787838829) [ 8310.320311] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8310.463548] alg: No test for adler32 (adler32-zlib) [ 8311.759532] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 8312.104893] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 8313.840521] Key type lgssc registered [ 8315.692670] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8370.732240] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8376.804554] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8399.874761] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8401.569270] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 8451.392815] Lustre: Unmounted lustre-client [ 8494.327882] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8494.837600] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 8530.929748] Lustre: Unmounted lustre-client [ 8561.249630] Key type lgssc unregistered [ 8561.629216] LNet: 167250:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8561.647757] LNetError: 167250:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8561.683531] LNet: Removed LNI 192.168.204.20@tcp [ 8562.819583] Key type .llcrypt unregistered [ 8562.823730] Key type ._llcrypt unregistered [ 8583.230529] Key type ._llcrypt registered [ 8583.233270] Key type .llcrypt registered [ 8584.802719] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 09:58:27 (1787839107) [ 8587.341131] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8587.394276] alg: No test for adler32 (adler32-zlib) [ 8588.479448] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 8588.823767] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 8590.593763] Key type lgssc registered [ 8591.944802] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8649.488615] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8655.852776] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8679.792773] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8682.605407] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 8703.684164] Lustre: Unmounted lustre-client [ 8731.250309] Key type lgssc unregistered [ 8731.504104] LNet: 171008:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8731.514775] LNetError: 171008:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8731.540453] LNet: Removed LNI 192.168.204.20@tcp [ 8732.465811] Key type .llcrypt unregistered [ 8732.467615] Key type ._llcrypt unregistered [ 8745.345907] Key type ._llcrypt registered [ 8745.351061] Key type .llcrypt registered [ 8745.767410] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8745.788884] alg: No test for adler32 (adler32-zlib) [ 8746.824736] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 8747.205754] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 8748.928214] Key type lgssc registered [ 8750.472563] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8807.191970] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8815.507608] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8840.731763] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8851.619680] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 8858.867984] Lustre: Unmounted lustre-client [ 8889.561285] Key type lgssc unregistered [ 8890.009451] LNet: 174090:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8890.015474] LNetError: 174090:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8890.046115] LNet: Removed LNI 192.168.204.20@tcp [ 8890.951368] Key type .llcrypt unregistered [ 8890.957598] Key type ._llcrypt unregistered [ 8908.264778] Key type ._llcrypt registered [ 8908.268898] Key type .llcrypt registered [ 8910.214037] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 10:03:52 (1787839432) [ 8913.366392] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8913.391642] alg: No test for adler32 (adler32-zlib) [ 8914.570429] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 8914.872841] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 8916.570123] Key type lgssc registered [ 8918.394800] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8976.914421] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8983.394663] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9007.481753] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9010.527882] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 9035.167298] Lustre: Unmounted lustre-client [ 9064.519739] Key type lgssc unregistered [ 9064.858907] LNet: 177850:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9064.872722] LNetError: 177850:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9064.902782] LNet: Removed LNI 192.168.204.20@tcp [ 9065.756771] Key type .llcrypt unregistered [ 9065.759138] Key type ._llcrypt unregistered [ 9079.805569] Key type ._llcrypt registered [ 9079.807353] Key type .llcrypt registered [ 9080.001695] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 9080.016772] alg: No test for adler32 (adler32-zlib) [ 9081.270336] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 9081.531924] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 9083.216217] Key type lgssc registered [ 9085.094752] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9145.000494] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9152.281969] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9179.119389] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9185.376779] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 9193.875667] Lustre: Unmounted lustre-client [ 9222.393375] Key type lgssc unregistered [ 9222.723194] LNet: 180925:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9222.727529] LNetError: 180925:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9222.758079] LNet: Removed LNI 192.168.204.20@tcp [ 9223.496705] Key type .llcrypt unregistered [ 9223.499141] Key type ._llcrypt unregistered [ 9242.059521] Key type ._llcrypt registered [ 9242.062236] Key type .llcrypt registered [ 9243.372423] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 10:09:26 (1787839766) [ 9269.521755] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9269.688086] alg: No test for adler32 (adler32-zlib) [ 9271.129196] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 9271.583128] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 9273.360398] Key type lgssc registered [ 9274.592474] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9363.674610] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9369.068564] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9394.336409] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9447.827632] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 10:12:50 (1787839970) [ 9497.563856] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9504.787966] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9529.856532] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9532.896309] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 9539.142522] Lustre: Unmounted lustre-client [ 9571.343483] Key type lgssc unregistered [ 9571.727362] LNet: 188028:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9571.756085] LNetError: 188028:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9571.775455] LNet: Removed LNI 192.168.204.20@tcp [ 9572.733254] Key type .llcrypt unregistered [ 9572.736053] Key type ._llcrypt unregistered [ 9591.080167] Key type ._llcrypt registered [ 9591.093253] Key type .llcrypt registered [ 9592.609969] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 9594.412914] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 10:15:17 (1787840117) [ 9616.882874] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9616.904115] alg: No test for adler32 (adler32-zlib) [ 9618.141785] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [ 9618.507839] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [ 9620.264325] Key type lgssc registered [ 9622.138403] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9727.907136] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9734.525848] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9758.846793] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9781.545456] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9784.328612] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [ 9810.146493] Lustre: Unmounted lustre-client [ 9948.584484] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9955.255867] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9979.613500] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10022.096717] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 10:22:24 (1787840544) [10024.472784] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [10026.470492] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 10:22:29 (1787840549) [10134.696925] Key type lgssc unregistered [10134.902874] LNet: 199473:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10134.912724] LNetError: 199473:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10134.924523] LNet: Removed LNI 192.168.204.20@tcp [10135.380198] Key type .llcrypt unregistered [10135.382558] Key type ._llcrypt unregistered [10152.244845] Key type ._llcrypt registered [10152.253736] Key type .llcrypt registered [10153.957072] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 10:24:36 (1787840676) [10199.333936] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10199.480107] alg: No test for adler32 (adler32-zlib) [10200.773836] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [10201.134037] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [10202.873119] Key type lgssc registered [10204.360086] Lustre: Echo OBD driver; http://www.lustre.org/ [10259.377712] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10265.312784] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10307.384994] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10354.244924] Key type lgssc unregistered [10354.544668] LNet: 203214:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10354.554962] LNetError: 203214:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10354.567816] LNet: Removed LNI 192.168.204.20@tcp [10355.372789] Key type .llcrypt unregistered [10355.376862] Key type ._llcrypt unregistered [10374.856869] Key type ._llcrypt registered [10374.858745] Key type .llcrypt registered [10376.446445] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 10:28:18 (1787840898) [10379.068405] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10379.081362] alg: No test for adler32 (adler32-zlib) [10380.105363] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [10380.423130] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [10382.184217] Key type lgssc registered [10383.632861] Lustre: Echo OBD driver; http://www.lustre.org/ [10445.034926] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10452.893063] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10481.912207] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10487.869110] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [10498.040402] Lustre: lustre-MDT0000-mdc-ffff8d8a841e5000: Connection to lustre-MDT0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [10508.272212] Lustre: lustre-MDT0001-mdc-ffff8d8a841e5000: Connection to lustre-MDT0001 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [10519.264814] Lustre: 204204:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787841027/real 1787841027] req@00000000cc672331 x1874687063834752/t0(0) o400->MGC192.168.204.120@tcp@192.168.204.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1787841043 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10519.290906] LustreError: MGC192.168.204.120@tcp: Connection to MGS (at 192.168.204.120@tcp) was lost; in progress operations using this service will fail [10544.108176] Lustre: Evicted from MGS (at 192.168.204.120@tcp) after server handle changed from 0xe26be84e8424df7d to 0xe26be84e8424fc64 [10544.147616] Lustre: MGC192.168.204.120@tcp: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [10558.475419] LustreError: lustre-MDT0000-mdc-ffff8d8a841e5000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [10558.515227] Lustre: lustre-MDT0000-mdc-ffff8d8a841e5000: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [10564.401848] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10566.457438] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10573.613504] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10575.921892] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [10579.697415] Lustre: Unmounted lustre-client [10609.018806] Key type lgssc unregistered [10609.277551] LNet: 208163:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10609.293672] LNetError: 208163:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10609.317642] LNet: Removed LNI 192.168.204.20@tcp [10610.178901] Key type .llcrypt unregistered [10610.182735] Key type ._llcrypt unregistered [10625.799327] Key type ._llcrypt registered [10625.802664] Key type .llcrypt registered [10627.274710] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 10:32:29 (1787841149) [10630.739162] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10630.839043] alg: No test for adler32 (adler32-zlib) [10632.396883] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [10632.846968] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [10634.537202] Key type lgssc registered [10637.217630] Lustre: Echo OBD driver; http://www.lustre.org/ [10698.005342] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10706.661393] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10774.145300] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10780.541423] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10819.722342] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10850.231381] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10900.755531] Key type lgssc unregistered [10901.113638] LNet: 213468:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10901.126780] LNetError: 213468:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10901.145612] LNet: Removed LNI 192.168.204.20@tcp [10902.144766] Key type .llcrypt unregistered [10902.148873] Key type ._llcrypt unregistered [10946.963111] Key type ._llcrypt registered [10946.965269] Key type .llcrypt registered [10948.465464] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 10:37:51 (1787841471) [10989.542664] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10989.710191] alg: No test for adler32 (adler32-zlib) [10990.968423] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [10991.280351] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [10992.984853] Key type lgssc registered [10994.506037] Lustre: Echo OBD driver; http://www.lustre.org/ [11089.032483] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11095.741942] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11122.091911] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11169.795171] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 10:41:32 (1787841692) [11178.918248] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 10:41:41 (1787841701) [11220.369754] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11227.950816] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11252.910510] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11264.062881] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [11269.711813] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [11272.690287] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [11274.686309] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [11276.671776] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [11279.341166] Lustre: lustre-MDT0000-mdc-ffff8d8a92acc800: Connection to lustre-MDT0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [11295.713774] Lustre: 215367:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787841803/real 1787841803] req@00000000523b80de x1874687704443392/t0(0) o400->MGC192.168.204.120@tcp@192.168.204.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1787841819 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11295.746224] LustreError: MGC192.168.204.120@tcp: Connection to MGS (at 192.168.204.120@tcp) was lost; in progress operations using this service will fail [11305.978742] Lustre: Evicted from MGS (at 192.168.204.120@tcp) after server handle changed from 0x997e3b49365a469a to 0x997e3b49365a4814 [11306.000890] Lustre: MGC192.168.204.120@tcp: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [11312.325712] Lustre: lustre-MDT0000-mdc-ffff8d8a92acc800: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [11322.623629] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11324.305804] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11328.131176] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [11331.569193] Lustre: lustre-MDT0000-mdc-ffff8d8a92acc800: Connection to lustre-MDT0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [11346.848266] Lustre: 215364:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1787841855/real 1787841855] req@00000000d101e170 x1874687704451968/t0(0) o400->MGC192.168.204.120@tcp@192.168.204.120@tcp:26/25 lens 224/224 e 0 to 1 dl 1787841871 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [11346.882303] LustreError: MGC192.168.204.120@tcp: Connection to MGS (at 192.168.204.120@tcp) was lost; in progress operations using this service will fail [11357.167716] Lustre: Evicted from MGS (at 192.168.204.120@tcp) after server handle changed from 0x997e3b49365a4814 to 0x997e3b49365a4b24 [11357.179880] Lustre: MGC192.168.204.120@tcp: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [11365.081480] Lustre: lustre-MDT0000-mdc-ffff8d8a92acc800: Connection restored to 192.168.204.120@tcp (at 192.168.204.120@tcp) [11375.307566] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11377.223708] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [11381.099232] Lustre: Unmounted lustre-client [11455.426459] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11462.372268] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11486.427651] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11487.155492] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [11495.546833] Lustre: Unmounted lustre-client [11524.887661] Key type lgssc unregistered [11525.170600] LNet: 225951:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11525.197385] LNetError: 225951:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11525.224890] LNet: Removed LNI 192.168.204.20@tcp [11526.026635] Key type .llcrypt unregistered [11526.028546] Key type ._llcrypt unregistered [11544.449528] Key type ._llcrypt registered [11544.459345] Key type .llcrypt registered [11545.848746] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 10:47:48 (1787842068) [11550.233740] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11550.270559] alg: No test for adler32 (adler32-zlib) [11551.595736] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [11552.121446] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [11553.849224] Key type lgssc registered [11555.370392] Lustre: Echo OBD driver; http://www.lustre.org/ [11605.788847] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11612.183644] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11633.764907] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11636.809323] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [11646.500391] Lustre: Unmounted lustre-client [11702.272127] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11708.057928] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11733.537618] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11734.152715] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [11742.705946] Lustre: Unmounted lustre-client [11816.419994] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11822.807450] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11843.943835] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11844.774262] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [11847.316919] Lustre: Unmounted lustre-client [11875.072672] Key type lgssc unregistered [11875.377749] LNet: 232997:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11875.384681] LNetError: 232997:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11875.413547] LNet: Removed LNI 192.168.204.20@tcp [11876.204818] Key type .llcrypt unregistered [11876.206654] Key type ._llcrypt unregistered [11893.502281] Key type ._llcrypt registered [11893.503621] Key type .llcrypt registered [11894.981576] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 10:53:37 (1787842417) [11898.595681] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11898.642961] alg: No test for adler32 (adler32-zlib) [11899.715985] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [11899.995035] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [11901.704201] Key type lgssc registered [11902.977361] Lustre: Echo OBD driver; http://www.lustre.org/ [11951.733974] Key type lgssc unregistered [11952.043567] LNet: 235321:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11952.050327] LNetError: 235321:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11952.098210] LNet: Removed LNI 192.168.204.20@tcp [11952.934826] Key type .llcrypt unregistered [11952.937113] Key type ._llcrypt unregistered [11985.252574] Key type ._llcrypt registered [11985.259436] Key type .llcrypt registered [11985.725306] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11985.735339] alg: No test for adler32 (adler32-zlib) [11986.890634] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [11987.171413] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [11988.896756] Key type lgssc registered [11990.358492] Lustre: Echo OBD driver; http://www.lustre.org/ [12079.610819] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12086.768602] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12113.303610] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12157.111971] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [12160.427368] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 10:58:02 (1787842682) [12196.896474] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12202.665043] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12226.007731] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12251.941877] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12253.747314] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [12258.805570] Lustre: lustre-OST0001-osc-ffff8d8a83f35000: Connection to lustre-OST0001 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [12266.252540] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12276.621151] Lustre: Unmounted lustre-client [12319.376894] Key type lgssc unregistered [12319.661751] LNet: 242442:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12319.678704] LNetError: 242442:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12319.701741] LNet: Removed LNI 192.168.204.20@tcp [12320.566934] Key type .llcrypt unregistered [12320.568963] Key type ._llcrypt unregistered [12353.723330] Key type ._llcrypt registered [12353.732109] Key type .llcrypt registered [12355.311353] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 11:01:17 (1787842877) [12369.400366] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12369.465782] alg: No test for adler32 (adler32-zlib) [12370.541629] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [12370.756545] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [12372.400643] Key type lgssc registered [12373.835647] Lustre: Echo OBD driver; http://www.lustre.org/ [12429.784687] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12436.195716] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12461.556521] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 11:03:04 (1787842984) [12499.789579] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12506.595676] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12530.467148] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12532.347074] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [12539.484663] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [12552.998315] Lustre: Unmounted lustre-client [12671.278980] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12678.753947] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12737.385458] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12738.068926] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [12740.754388] Lustre: Unmounted lustre-client [12769.395608] Key type lgssc unregistered [12769.637129] LNet: 250156:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12769.644959] LNetError: 250156:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12769.672865] LNet: Removed LNI 192.168.204.20@tcp [12770.432505] Key type .llcrypt unregistered [12770.435139] Key type ._llcrypt unregistered [12805.977762] Key type ._llcrypt registered [12805.988871] Key type .llcrypt registered [12806.458460] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12806.473554] alg: No test for adler32 (adler32-zlib) [12807.663498] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [12807.968729] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [12809.688202] Key type lgssc registered [12811.123407] Lustre: Echo OBD driver; http://www.lustre.org/ [12907.453729] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12914.481595] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12945.448986] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13001.546373] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [13003.774745] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 11:12:06 (1787843526) [13041.173528] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13047.890908] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13076.914032] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13082.457933] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [13087.874780] Lustre: Unmounted lustre-client [13119.870709] Key type lgssc unregistered [13120.196315] LNet: 256805:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13120.214458] LNetError: 256805:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13120.251890] LNet: Removed LNI 192.168.204.20@tcp [13121.029739] Key type .llcrypt unregistered [13121.032603] Key type ._llcrypt unregistered [13139.942545] Key type ._llcrypt registered [13139.945929] Key type .llcrypt registered [13141.839865] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [13144.396823] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 11:14:26 (1787843666) [13155.033411] Key type .llcrypt unregistered [13155.038968] Key type ._llcrypt unregistered [13165.590688] Key type ._llcrypt registered [13165.596791] Key type .llcrypt registered [13166.240726] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13166.274329] alg: No test for adler32 (adler32-zlib) [13167.438385] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [13167.664800] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [13169.320255] Key type lgssc registered [13171.041381] Lustre: Echo OBD driver; http://www.lustre.org/ [13234.608632] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13254.119137] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [13257.908084] Lustre: Unmounted lustre-client [13284.978210] Key type lgssc unregistered [13285.362329] LNet: 260268:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13285.371486] LNetError: 260268:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13285.393962] LNet: Removed LNI 192.168.204.20@tcp [13286.549199] Key type .llcrypt unregistered [13286.550811] Key type ._llcrypt unregistered [13307.237549] Key type ._llcrypt registered [13307.240571] Key type .llcrypt registered [13309.208747] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 11:17:11 (1787843831) [13312.654108] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13312.725883] alg: No test for adler32 (adler32-zlib) [13313.953370] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [13314.397104] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [13316.234782] Key type lgssc registered [13318.675312] Lustre: Echo OBD driver; http://www.lustre.org/ [13414.841600] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13460.193646] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13467.503524] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13470.305200] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [13473.441364] Lustre: Unmounted lustre-client [13513.177973] Key type lgssc unregistered [13513.452350] LNet: 263819:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13513.464506] LNetError: 263819:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13513.502178] LNet: Removed LNI 192.168.204.20@tcp [13514.266100] Key type .llcrypt unregistered [13514.267567] Key type ._llcrypt unregistered [13532.953191] Key type ._llcrypt registered [13532.954737] Key type .llcrypt registered [13534.485448] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 11:20:57 (1787844057) [13537.066632] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13537.233044] alg: No test for adler32 (adler32-zlib) [13538.401613] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [13538.773840] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [13540.504207] Key type lgssc registered [13542.192309] Lustre: Echo OBD driver; http://www.lustre.org/ [13599.067921] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13605.459158] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13629.222297] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13632.145724] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [13637.114386] Lustre: lustre-MDT0000-mdc-ffff8d8a852f9800: Connection to lustre-MDT0000 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [13642.784637] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [13642.806563] LustreError: 266984:0:(file.c:6176:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [13643.159283] LustreError: MGC192.168.204.120@tcp: Connection to MGS (at 192.168.204.120@tcp) was lost; in progress operations using this service will fail [13643.239707] Lustre: Unmounted lustre-client [13664.082466] Key type lgssc unregistered [13664.356343] LNet: 267399:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13664.368110] LNetError: 267399:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13664.406869] LNet: Removed LNI 192.168.204.20@tcp [13665.100466] Key type .llcrypt unregistered [13665.104166] Key type ._llcrypt unregistered [13680.812122] Key type ._llcrypt registered [13680.815510] Key type .llcrypt registered [13682.158225] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 11:23:24 (1787844204) [13685.250379] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13685.262425] alg: No test for adler32 (adler32-zlib) [13686.351030] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [13686.733809] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [13688.432264] Key type lgssc registered [13690.067524] Lustre: Echo OBD driver; http://www.lustre.org/ [13742.866578] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13748.344452] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13769.748834] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13771.735389] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [13776.881891] Lustre: lustre-MDT0001-mdc-ffff8d8a84995000: Connection to lustre-MDT0001 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [13783.109386] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [13786.558596] Lustre: Unmounted lustre-client [13807.127630] Key type lgssc unregistered [13807.434027] LNet: 270982:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13807.456250] LNetError: 270982:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13807.490486] LNet: Removed LNI 192.168.204.20@tcp [13808.372226] Key type .llcrypt unregistered [13808.377382] Key type ._llcrypt unregistered [13826.263940] Key type ._llcrypt registered [13826.267860] Key type .llcrypt registered [13828.006811] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 11:25:50 (1787844350) [13850.180815] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [13850.218315] alg: No test for adler32 (adler32-zlib) [13851.455453] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [13851.749695] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [13853.512631] Key type lgssc registered [13854.821331] Lustre: Echo OBD driver; http://www.lustre.org/ [13983.036906] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13984.897630] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [14036.990468] Lustre: lustre-MDT0001-mdc-ffff8d8a84587800: Connection to lustre-MDT0001 (at 192.168.204.120@tcp) was lost; in progress operations using this service will wait for recovery to complete [14043.815715] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [14054.129233] Lustre: Unmounted lustre-client [14082.427072] Key type lgssc unregistered [14082.645087] LNet: 276775:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14082.648752] LNetError: 276775:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14082.681892] LNet: Removed LNI 192.168.204.20@tcp [14083.410145] Key type .llcrypt unregistered [14083.414303] Key type ._llcrypt unregistered [14102.817553] Key type ._llcrypt registered [14102.823382] Key type .llcrypt registered [14104.627930] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 11:30:26 (1787844626) [14106.933570] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [14108.980225] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 11:30:31 (1787844631) [14110.900350] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [14112.993716] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 11:30:35 (1787844635) [14114.720953] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [14116.792609] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 11:30:39 (1787844639) [14118.821672] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [14121.463812] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 11:30:43 (1787844643) [14123.837641] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [14126.349327] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 11:30:48 (1787844648) [14137.436472] Key type .llcrypt unregistered [14137.441614] Key type ._llcrypt unregistered [14146.664429] Key type ._llcrypt registered [14146.672960] Key type .llcrypt registered [14147.319568] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14147.339700] alg: No test for adler32 (adler32-zlib) [14148.673343] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [14148.907792] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [14150.632314] Key type lgssc registered [14152.247498] Lustre: Echo OBD driver; http://www.lustre.org/ [14236.035903] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14242.911675] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14269.634525] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14272.605717] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [14277.413884] Lustre: Unmounted lustre-client [14309.302993] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 11:33:52 (1787844832) [14350.839448] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14357.492973] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14398.769567] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14399.618702] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [14402.556616] Lustre: Unmounted lustre-client [14448.183246] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 11:36:10 (1787844970) [14450.977594] LNet: 1 local NIs in recovery (showing 1): 192.168.204.20@tcp [15101.784845] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15108.240175] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15145.674717] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15251.820979] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 11:49:34 (1787845774) [15265.377419] Key type lgssc unregistered [15265.729948] LNet: 290315:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15265.737378] LNetError: 290315:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15266.794107] LNet: Removed LNI 192.168.204.20@tcp [15267.669447] Key type .llcrypt unregistered [15267.671306] Key type ._llcrypt unregistered [15395.405295] Key type ._llcrypt registered [15395.415887] Key type .llcrypt registered [15395.887608] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15395.899636] alg: No test for adler32 (adler32-zlib) [15397.047250] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [15397.340523] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [15399.048186] Key type lgssc registered [15400.357841] Lustre: Echo OBD driver; http://www.lustre.org/ [15509.943706] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15517.100786] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15547.923116] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15587.509820] Key type lgssc unregistered [15587.739043] LNet: 294017:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15587.763172] LNetError: 294017:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15587.791094] LNet: Removed LNI 192.168.204.20@tcp [15588.649860] Key type .llcrypt unregistered [15588.654842] Key type ._llcrypt unregistered [15629.132690] Key type ._llcrypt registered [15629.137951] Key type .llcrypt registered [15631.091601] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 11:55:53 (1787846153) [15659.167679] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15659.217604] alg: No test for adler32 (adler32-zlib) [15660.437675] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [15660.793829] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [15662.584288] Key type lgssc registered [15663.820543] Lustre: Echo OBD driver; http://www.lustre.org/ [15725.915787] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 11:57:28 (1787846248) [15741.905422] Key type lgssc unregistered [15742.246861] LNet: 297576:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15742.253547] LNetError: 297576:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15742.282610] LNet: Removed LNI 192.168.204.20@tcp [15742.982714] Key type .llcrypt unregistered [15742.984813] Key type ._llcrypt unregistered [15757.379684] Key type ._llcrypt registered [15757.385371] Key type .llcrypt registered [15758.091773] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [15758.112904] alg: No test for adler32 (adler32-zlib) [15759.270431] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [15759.515514] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [15761.232381] Key type lgssc registered [15762.957897] Lustre: Echo OBD driver; http://www.lustre.org/ [15829.342504] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15836.070909] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15864.317574] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16235.377151] LNet: Added LNI 192.168.204.20@tcp50 [8/256/0/180] [16237.632667] LNet: Removed LNI 192.168.204.20@tcp [16240.286096] Lustre: 302006:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8d8a84997000: config has no valid NIDs, force dynamic NIDs [16241.587609] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [16241.809353] Lustre: Unmounted lustre-client [16245.222310] Key type lgssc unregistered [16245.647653] LNet: 302269:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16245.658069] LNetError: 302269:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16245.698977] LNet: Removed LNI 192.168.204.20@tcp50 [16246.488454] Key type .llcrypt unregistered [16246.490335] Key type ._llcrypt unregistered [16268.915924] Key type ._llcrypt registered [16268.919604] Key type .llcrypt registered [16269.603536] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [16269.626886] alg: No test for adler32 (adler32-zlib) [16271.022852] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [16271.555786] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [16273.450303] Key type lgssc registered [16275.094844] Lustre: Echo OBD driver; http://www.lustre.org/ [16336.252615] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16342.547643] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16350.911843] LNet: Added LNI 192.168.204.20@tcp50 [8/256/0/180] [16351.779693] LNet: Removed LNI 192.168.204.20@tcp [16352.994917] Lustre: 304963:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff8d8a89bce000: config has no valid NIDs, force dynamic NIDs [16354.236256] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [16354.763977] Lustre: Unmounted lustre-client [16393.951457] Key type lgssc unregistered [16394.468648] LNet: 305838:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16394.492239] LNetError: 305838:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16395.563513] LNet: Removed LNI 192.168.204.20@tcp50 [16396.296694] Key type .llcrypt unregistered [16396.310198] Key type ._llcrypt unregistered [16410.618747] Key type ._llcrypt registered [16410.623434] Key type .llcrypt registered [16412.709629] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 12:08:54 (1787846934) [16433.480770] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16433.530091] alg: No test for adler32 (adler32-zlib) [16434.663932] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [16435.079091] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [16436.808901] Key type lgssc registered [16438.354858] Lustre: Echo OBD driver; http://www.lustre.org/ [16533.436769] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16540.865252] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16570.819900] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16616.355396] Key type lgssc unregistered [16616.657046] LNet: 310598:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16616.671168] LNetError: 310598:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16616.686218] LNet: Removed LNI 192.168.204.20@tcp [16617.568254] Key type .llcrypt unregistered [16617.575600] Key type ._llcrypt unregistered [16634.512262] Key type ._llcrypt registered [16634.516151] Key type .llcrypt registered [16636.795851] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 12:12:38 (1787847158) [16640.868528] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16640.988583] alg: No test for adler32 (adler32-zlib) [16642.652885] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [16643.081476] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [16644.920885] Key type lgssc registered [16646.651374] Lustre: Echo OBD driver; http://www.lustre.org/ [16702.294271] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [16708.606938] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [16733.111671] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [16735.955970] Lustre: Mounted lustre-client - version 2.17.57_61_g678d580 [16802.801056] Lustre: Mounted fs15246-client - version 2.17.57_61_g678d580 [16819.075432] Lustre: Unmounted fs15246-client [16848.507290] Lustre: Unmounted lustre-client [16885.943722] Key type lgssc unregistered [16886.282788] LNet: 315471:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [16886.289738] LNetError: 315471:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [16886.299530] LNet: Removed LNI 192.168.204.20@tcp [16886.904310] Key type .llcrypt unregistered [16886.907408] Key type ._llcrypt unregistered [16899.651544] Key type ._llcrypt registered [16899.653843] Key type .llcrypt registered [16901.100966] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 12:17:03 (1787847423) [16903.102922] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [16903.122019] alg: No test for adler32 (adler32-zlib) [16904.260947] Lustre: Lustre: Build Version: 2.17.57_61_g678d580 [16904.582049] LNet: Added LNI 192.168.204.20@tcp [8/256/0/180] [16906.288519] Key type lgssc registered [16907.827440] Lustre: Echo OBD driver; http://www.lustre.org/ [17060.800662] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [17067.882296] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [17090.695934] Lustre: DEBUG MARKER: oleg420-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [17200.517516] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 16871 sec ========= 12:22:02 (1787847722) [17202.812954] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 12:22:05 (1787847725) === [17207.787541] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 12:22:09 (1787847729) === [17245.822812] Key type lgssc unregistered [17246.173059] LNet: 324744:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [17246.180914] LNetError: 324744:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [17246.200348] LNet: Removed LNI 192.168.204.20@tcp [17247.121876] Key type .llcrypt unregistered [17247.126094] Key type ._llcrypt unregistered