[ 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 442403878 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.000000] last_pfn = 0x146e00 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [ 0.000000] last_pfn = 0xbffda max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f54d0-0x000f54df] [ 0.000000] RAMDISK: [mem 0xbcc64000-0xbffcffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F52F0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x00000000BFFE2464 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x00000000BFFE2300 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x00000000BFFE0040 0022C0 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.000000] ACPI: APIC 0x00000000BFFE2374 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x00000000BFFE2404 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 0x00000000BFFE243C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Reserving FACP table memory at [mem 0xbffe2300-0xbffe2373] [ 0.000000] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22ff] [ 0.000000] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] [ 0.000000] ACPI: Reserving APIC table memory at [mem 0xbffe2374-0xbffe2403] [ 0.000000] ACPI: Reserving HPET table memory at [mem 0xbffe2404-0xbffe243b] [ 0.000000] ACPI: Reserving WAET table memory at [mem 0xbffe243c-0xbffe2463] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000146dfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1465a3000-0x1465cdfff] [ 0.000000] Reserving 256MB of memory at 2752MB for crashkernel (System RAM: 4205MB) [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.000000] Normal [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000bffd9fff] [ 0.000000] node 0: [mem 0x0000000100000000-0x0000000146dfffff] [ 0.000000] Zeroed struct page in unavailable ranges: 4744 pages [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000146dfffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] TSC deadline timer available [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] kvm-guest: KVM setup pv remote TLB flush [ 0.000000] kvm-guest: setup PV sched yield [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffda000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 63 pages/cpu s221184 r8192 d28672 u524288 [ 0.000000] kvm-guest: PV spinlocks enabled [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1059618 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:rocky8.10:ext4:ro:-p,-b4096 ro crashkernel=256M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] Specific versions of hardware are certified with Red Hat Enterprise Linux 8. Please see the list of hardware certified with Red Hat Enterprise Linux 8 at https://catalog.redhat.com. [ 0.000000] audit: disabled (until reboot) [ 0.000000] software IO TLB: area num 4. [ 0.000000] Memory: 2829700K/4306400K available (18435K kernel code, 11221K rwdata, 7248K rodata, 2908K init, 18040K bss, 524584K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001010] APIC: Switch to symmetric I/O mode setup [ 0.003154] x2apic enabled [ 0.004008] Switched APIC routing to physical x2apic. [ 0.005012] kvm-guest: setup PV IPIs [ 0.008000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.008000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 0.008018] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009011] pid_max: default: 32768 minimum: 301 [ 0.010142] LSM: Security Framework initializing [ 0.011062] Yama: becoming mindful. [ 0.012038] SELinux: Initializing. [ 0.013073] *** VALIDATE selinux *** [ 0.021508] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026288] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027164] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028107] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.029129] *** VALIDATE tmpfs *** [ 0.031216] *** VALIDATE proc *** [ 0.032259] *** VALIDATE cgroup *** [ 0.033009] *** VALIDATE cgroup2 *** [ 0.034267] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.035154] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.036010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.037037] Spectre V2 : User space: Vulnerable [ 0.038008] Speculative Store Bypass: Vulnerable [ 0.041013] debug: unmapping init [mem 0xffffffff87e59000-0xffffffff87e60fff] [ 0.043174] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.044683] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.045023] ... version: 2 [ 0.046012] ... bit width: 48 [ 0.047024] ... generic registers: 4 [ 0.048013] ... value mask: 0000ffffffffffff [ 0.049015] ... max period: 00007fffffffffff [ 0.050015] ... fixed-purpose events: 3 [ 0.051011] ... event mask: 000000070000000f [ 0.052286] rcu: Hierarchical SRCU implementation. [ 0.054407] smp: Bringing up secondary CPUs ... [ 0.055581] x86: Booting SMP configuration: [ 0.056022] .... node #0, CPUs: #1 #2 #3 [ 0.059466] smp: Brought up 1 node, 4 CPUs [ 0.061011] smpboot: Max logical packages: 1 [ 0.062020] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.144022] node 0 deferred pages initialised in 77ms [ 0.148073] devtmpfs: initialized [ 0.149299] x86/mm: Memory block size: 128MB [ 0.152717] gcov: version magic: 0x41383552 [ 0.155194] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.158096] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.160311] pinctrl core: initialized pinctrl subsystem [ 0.163176] [ 0.163712] ************************************************************* [ 0.165011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.168014] ** ** [ 0.170010] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.171010] ** ** [ 0.173009] ** This means that this kernel is built to expose internal ** [ 0.175025] ** IOMMU data structures, which may compromise security on ** [ 0.177011] ** your system. ** [ 0.179014] ** ** [ 0.182022] ** If you see this message and you are not debugging the ** [ 0.184011] ** kernel, report this immediately to your vendor! ** [ 0.186014] ** ** [ 0.188011] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.190012] ************************************************************* [ 0.192650] NET: Registered protocol family 16 [ 0.194316] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.197054] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.199055] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.203028] cpuidle: using governor menu [ 0.204764] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.207035] PCI: Using configuration type 1 for base access [ 0.209126] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.218057] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.220079] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.224032] cryptd: max_cpu_qlen set to 1000 [ 0.226240] ACPI: Added _OSI(Module Device) [ 0.228014] ACPI: Added _OSI(Processor Device) [ 0.229017] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.231014] ACPI: Added _OSI(Processor Aggregator Device) [ 0.235302] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.240518] ACPI: Interpreter enabled [ 0.242086] ACPI: PM: (supports S0 S3 S4 S5) [ 0.243009] ACPI: Using IOAPIC for interrupt routing [ 0.244080] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.247299] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.256865] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.259048] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.262023] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.267075] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.272461] acpiphp: Slot [2] registered [ 0.274116] acpiphp: Slot [5] registered [ 0.276138] acpiphp: Slot [6] registered [ 0.278130] acpiphp: Slot [3] registered [ 0.279156] acpiphp: Slot [4] registered [ 0.282129] acpiphp: Slot [7] registered [ 0.284137] acpiphp: Slot [8] registered [ 0.286116] acpiphp: Slot [9] registered [ 0.288140] acpiphp: Slot [10] registered [ 0.289118] acpiphp: Slot [11] registered [ 0.291112] acpiphp: Slot [12] registered [ 0.293122] acpiphp: Slot [13] registered [ 0.295137] acpiphp: Slot [14] registered [ 0.296171] acpiphp: Slot [15] registered [ 0.298107] acpiphp: Slot [16] registered [ 0.300119] acpiphp: Slot [17] registered [ 0.302124] acpiphp: Slot [18] registered [ 0.303153] acpiphp: Slot [19] registered [ 0.305101] acpiphp: Slot [20] registered [ 0.307077] acpiphp: Slot [21] registered [ 0.309108] acpiphp: Slot [22] registered [ 0.311141] acpiphp: Slot [23] registered [ 0.313137] acpiphp: Slot [24] registered [ 0.315109] acpiphp: Slot [25] registered [ 0.316099] acpiphp: Slot [26] registered [ 0.318117] acpiphp: Slot [27] registered [ 0.319111] acpiphp: Slot [28] registered [ 0.321133] acpiphp: Slot [29] registered [ 0.322084] acpiphp: Slot [30] registered [ 0.323087] acpiphp: Slot [31] registered [ 0.325062] PCI host bridge to bus 0000:00 [ 0.326019] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.328020] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.330023] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.333028] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.334027] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.337025] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.339175] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.341828] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.345448] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.355014] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.359014] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.362019] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.365026] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.368017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.370869] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.372610] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.375046] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.377775] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.381912] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.392017] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.396013] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.400923] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.405769] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.411013] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.424014] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.432963] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.441014] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.446014] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.460016] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.471327] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.474440] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.476385] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.479432] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.481253] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.487029] iommu: Default domain type: Passthrough [ 0.488384] SCSI subsystem initialized [ 0.490136] ACPI: bus type USB registered [ 0.491121] usbcore: registered new interface driver usbfs [ 0.493063] usbcore: registered new interface driver hub [ 0.494076] usbcore: registered new device driver usb [ 0.496156] pps_core: LinuxPPS API ver. 1 registered [ 0.498011] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.501057] PTP clock support registered [ 0.503132] EDAC MC: Ver: 3.0.0 [ 0.505159] PCI: Using ACPI for IRQ routing [ 0.506592] NetLabel: Initializing [ 0.508010] NetLabel: domain hash size = 128 [ 0.510011] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.512077] NetLabel: unlabeled traffic allowed by default [ 0.514111] vgaarb: loaded [ 0.515265] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.517014] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.523344] clocksource: Switched to clocksource kvm-clock [ 0.630701] VFS: Disk quotas dquot_6.6.0 [ 0.632366] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.634718] *** VALIDATE ramfs *** [ 0.636375] *** VALIDATE hugetlbfs *** [ 0.638049] pnp: PnP ACPI init [ 0.640506] pnp: PnP ACPI: found 6 devices [ 0.662128] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.665312] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.667228] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.668891] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.671028] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.673478] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.676210] NET: Registered protocol family 2 [ 0.678400] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.682868] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.686801] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.691388] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.694721] TCP: Hash tables configured (established 65536 bind 65536) [ 0.698049] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.700554] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.703243] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.706302] NET: Registered protocol family 1 [ 0.709241] RPC: Registered named UNIX socket transport module. [ 0.711473] RPC: Registered udp transport module. [ 0.713327] RPC: Registered tcp transport module. [ 0.715169] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.717558] NET: Registered protocol family 44 [ 0.719464] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.721707] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.723988] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.725949] PCI: CLS 0 bytes, default 64 [ 0.727571] Unpacking initramfs... [ 2.145411] debug: unmapping init [mem 0xffff93d4fcc64000-0xffff93d4fffcffff] [ 2.149136] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.151665] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.154741] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.685825] Initialise system trusted keyrings [ 2.688073] Key type blacklist registered [ 2.689979] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.700414] zbud: loaded [ 2.703808] *** VALIDATE nfs *** [ 2.705179] *** VALIDATE nfs4 *** [ 2.706664] pstore: using deflate compression [ 2.710141] Platform Keyring initialized [ 2.819746] NET: Registered protocol family 38 [ 2.821585] Key type asymmetric registered [ 2.823152] Asymmetric key parser 'x509' registered [ 2.825571] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.829029] io scheduler mq-deadline registered [ 2.830497] io scheduler kyber registered [ 2.831880] io scheduler bfq registered [ 2.833725] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.836472] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.839318] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.841957] ACPI: Power Button [PWRF] [ 2.847478] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.854537] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.865872] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.892623] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.923015] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.929068] Non-volatile memory driver v1.3 [ 2.930973] Linux agpgart interface v0.103 [ 2.964027] virtio_blk virtio1: [vda] 145896 512-byte logical blocks (74.7 MB/71.2 MiB) [ 2.967648] vda: detected capacity change from 0 to 74698752 [ 2.986428] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.989838] vdb: detected capacity change from 0 to 1073741824 [ 2.997896] libphy: Fixed MDIO Bus: probed [ 3.009437] usbcore: registered new interface driver usbserial_generic [ 3.012556] usbserial: USB Serial support registered for generic [ 3.014960] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.019128] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.020890] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.023263] mousedev: PS/2 mouse device common for all mice [ 3.026444] rtc_cmos 00:05: RTC can wake from S4 [ 3.029358] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.032583] rtc_cmos 00:05: registered as rtc0 [ 3.035766] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.036295] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 3.040374] intel_pstate: CPU model not supported [ 3.046456] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 3.056865] hid: raw HID events driver (C) Jiri Kosina [ 3.059605] usbcore: registered new interface driver usbhid [ 3.062191] usbhid: USB HID core driver [ 3.063912] drop_monitor: Initializing network drop monitor service [ 3.066587] Initializing XFRM netlink socket [ 3.068774] NET: Registered protocol family 10 [ 3.071575] Segment Routing with IPv6 [ 3.073117] NET: Registered protocol family 17 [ 3.075050] mpls_gso: MPLS GSO support [ 3.079431] RAS: Correctable Errors collector initialized. [ 3.081980] AVX version of gcm_enc/dec engaged. [ 3.083662] AES CTR mode by8 optimization enabled [ 3.153753] sched_clock: Marking stable (3153673427, 0)->(4054746607, -901073180) [ 3.157722] registered taskstats version 1 [ 3.160298] Loading compiled-in X.509 certificates [ 3.162438] zswap: loaded using pool lzo/zbud [ 3.195097] Key type big_key registered [ 3.207329] Key type encrypted registered [ 3.208968] ima: No TPM chip found, activating TPM-bypass! [ 3.211162] ima: Allocated hash algorithm: sha1 [ 3.212728] ima: No architecture policies found [ 3.214408] evm: Initialising EVM extended attributes: [ 3.216184] evm: security.selinux [ 3.217541] evm: security.ima [ 3.218630] evm: security.capability [ 3.219751] evm: HMAC attrs: 0x1 [ 3.221908] rtc_cmos 00:05: setting system clock to 2026-09-03 13:18:17 UTC (1788441497) [ 3.226278] debug: unmapping init [mem 0xffffffff88e03000-0xffffffff88ffffff] [ 3.230184] debug: unmapping init [mem 0xffffffff87b82000-0xffffffff87e58fff] [ 3.239095] Write protecting the kernel read-only data: 28672k [ 3.242508] debug: unmapping init [mem 0xffffffff86203000-0xffffffff863fffff] [ 3.245295] debug: unmapping init [mem 0xffffffff86b14000-0xffffffff86bfffff] [ 3.275135] 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.285182] systemd[1]: Detected virtualization kvm. [ 3.286980] systemd[1]: Detected architecture x86-64. [ 3.288882] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.315447] systemd[1]: No hostname configured. [ 3.317523] systemd[1]: Set hostname to . [ 3.319842] random: systemd: uninitialized urandom read (16 bytes read) [ 3.322482] systemd[1]: Initializing machine ID from random generator. [ 3.348073] random: ln: uninitialized urandom read (6 bytes read) [ 3.443425] random: systemd: uninitialized urandom read (16 bytes read) [ 3.446341] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 3.454409] systemd[1]: Reached target Paths. [ OK ] Reached target Paths. [ 3.458199] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ OK ] Listening on udev Kernel Socket. [ OK ] Reached target Timers. [ OK ] Reached target Swap. [ OK ] Reached target Local File Systems. [ OK ] Reached target Initrd Root Device. [ OK ] Reached target Slices. [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket. Starting Create Volatile Files and Directories... [ OK ] Reached target Sockets. Starting Journal Service... Starting Apply Kernel Variables... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Local Encrypted Volumes. Starting Setup Virtual Console... [ OK ] Started Create Volatile Files and Directories. [ OK ] Started Apply Kernel Variables. [ 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 Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 4.041558] device-mapper: uevent: version 1.0.3 [ 4.043942] 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. [ 4.792912] virtio_net virtio0 ens2: renamed from eth0 [ 5.050212] scsi host0: ata_piix [ 5.067210] scsi host1: ata_piix [ 5.068622] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 5.070681] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.598428] dracut-initqueue[582]: RTNETLINK answers: File exists [ 9.724054] random: crng init done [ 9.725453] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 10.080566] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ OK ] Mounted /sysroot. [ OK ] Reached target Initrd Root File System. Starting Reload Configuration from the Real Root... [ OK ] Started Reload Configuration from the Real Root. [ OK ] Reached target Initrd File Systems. [ OK ] Reached target Initrd Default Target. Starting dracut pre-pivot and cleanup hook... [ OK ] Started dracut pre-pivot and cleanup hook. Starting Cleaning Up and Shutting Down Daemons... [ OK ] Stopped target Timers. Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target System Initialization. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Apply Kernel Variables. Stopping udev Kernel Device Manager... [ OK ] Stopped target Swap. [ OK ] Stopped target Slices. [ OK ] Stopped target Paths. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Closed udev Control Socket. [ OK ] Closed udev Kernel Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.179736] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.441364] SELinux: Disabled at runtime. [ 11.497741] 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.505969] systemd[1]: Detected virtualization kvm. [ 11.507765] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 12.013019] systemd[1]: initrd-switch-root.service: Succeeded. [ 12.016305] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 12.021154] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 12.025191] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 12.028531] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 12.041314] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.046506] systemd[1]: Stopped target Switch Root. [ OK ] Stopped target Switch Root. [ OK ] Reached target rpc_pipefs.target. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-getty.slice. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Starting Create list of required st…ce nodes for the current kernel... Mounting POSIX Message Queue File System... [ OK ] Listening on udev Control Socket. [ OK ] Listening on initctl Compatibility Named Pipe. Mounting Huge Pages File System... [ OK ] Listening on udev Kernel Socket. Starting udev Coldplug all Devices... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Stopped target Initrd Root File System. [ OK ] Listening on Process Core Dump Socket. [ OK ] Started Dispatch Password Requests to Console Directory Watch. Mounting Kernel Debug File System... [ OK ] Created slice User and Session Slice. [ OK ] Reached target Slices. Starting Apply Kernel Variables... [ OK ] Stopped target Initrd File Systems. [ OK ] Listening on RPCbind Server Activation Socket. [ OK ] Reached target RPC Port Mapper. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Created slice system-sshd\x2dkeygen.slice. Activating swap /dev/disk/by-label/SWAP... [ OK ] Reached target Paths. [ OK ] Started Journal Service. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ 12.229948] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted POSIX Message Queue File System. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted Kernel Debug File System. [ 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 /mnt... Mounting /home/green/git/lustre-release... Starting udev Kernel Device Manager... [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /mnt. [ 12.444523] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Started udev Kernel Device Manager. [ 12.718433] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.735231] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.804039] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.821528] EDAC sbridge: Ver: 1.1.2 [ 13.951173] Key type dns_resolver registered [ 14.261877] NFS: Registering the id_resolver key type [ 14.264092] Key type id_resolver registered [ 14.265507] Key type id_legacy registered [ OK ] Started Configure read-only root support. [ OK ] Reached target Local File Systems. Starting Mark the need to relabel after reboot... Starting Create Volatile Files and Directories... Starting Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC Bind... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started dnf makecache --timer. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Reached target Basic System. Starting Restore /run/initramfs on shutdown... [ OK ] Reached target sshd-keygen.target. [ OK ] Started D-Bus System Message Bus. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started irqbalance daemon. Starting Network Manager... Starting Login Service... [ 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 Dynamic System Tuning Daemon... Starting GSSAPI Proxy Daemon... Starting OpenSSH server daemon... Starting Hostname Service... [ OK ] Started GSSAPI Proxy Daemon. [ OK ] Reached target NFS client services. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Permit User Sessions... [ OK ] Started OpenSSH server daemon. [ OK ] Started Permit User Sessions. [ OK ] Started Command Scheduler. [ OK ] Started Serial Getty on ttyS1. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ 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 Crash recovery kernel arming... Starting System Logging Service... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. Starting Authorization Manager... [ OK ] Started Authorization Manager. [ OK ] Started Dynamic System Tuning Daemon. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Rocky Linux 8.10 (Green Obsidian) Kernel 4.18.0rh8.10-debug on an x86_64 oleg623-client login: [ 66.742034] libcfs: loading out-of-tree module taints kernel. [ 66.983678] Key type ._llcrypt registered [ 66.986482] Key type .llcrypt registered [ 67.416697] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 67.427641] alg: No test for adler32 (adler32-zlib) [ 68.857828] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 70.204603] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 72.055128] Key type lgssc registered [ 73.896582] Lustre: Echo OBD driver; http://www.lustre.org/ [ 149.476678] hrtimer: interrupt took 4580380 ns [ 248.348960] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 253.028864] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 267.972554] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing check_logdir /tmp/testlogs/ [ 273.890198] Lustre: lustre-OST0000-osc-ffff93d547e15800: disconnect after 24s idle [ 274.655443] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing yml_node [ 278.412146] Lustre: DEBUG MARKER: Client: 2.17.56.51 [ 280.685427] Lustre: DEBUG MARKER: MDS: 2.17.56.51 [ 283.450175] Lustre: DEBUG MARKER: OSS: 2.17.56.51 [ 285.210952] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Sep 3 09:22:57 EDT 2026 [ 300.187632] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 301.731796] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 304.318870] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 314.670488] Lustre: Unmounted lustre-client [ 429.971356] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 436.143201] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 459.533721] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 496.397973] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 09:26:29 (1788441989) [ 498.387571] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 500.026187] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 09:26:32 (1788441992) [ 530.555983] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 536.090850] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 555.003724] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 555.698629] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 560.442191] Lustre: Unmounted lustre-client [ 587.803501] Key type lgssc unregistered [ 588.096157] LNet: 15032:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 588.113200] LNetError: 15032:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 588.133102] LNet: Removed LNI 192.168.206.23@tcp [ 589.085330] Key type .llcrypt unregistered [ 589.089507] Key type ._llcrypt unregistered [ 603.746654] Key type ._llcrypt registered [ 603.755112] Key type .llcrypt registered [ 605.162227] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 09:28:17 (1788442097) [ 606.113183] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 606.130077] alg: No test for adler32 (adler32-zlib) [ 607.235947] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 607.469941] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 609.183197] Key type lgssc registered [ 610.448555] Lustre: Echo OBD driver; http://www.lustre.org/ [ 684.833903] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 766.165650] Lustre: Unmounted lustre-client [ 791.231216] Key type lgssc unregistered [ 791.462175] LNet: 18855:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 791.471850] LNetError: 18855:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 791.491222] LNet: Removed LNI 192.168.206.23@tcp [ 792.213593] Key type .llcrypt unregistered [ 792.215900] Key type ._llcrypt unregistered [ 800.742535] Key type ._llcrypt registered [ 800.745951] Key type .llcrypt registered [ 801.933602] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 09:31:34 (1788442294) [ 804.297787] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 804.310265] alg: No test for adler32 (adler32-zlib) [ 805.427786] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 805.649337] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 807.344654] Key type lgssc registered [ 808.435204] Lustre: Echo OBD driver; http://www.lustre.org/ [ 857.119963] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 862.732417] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 883.224476] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 884.878553] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 898.627857] Lustre: Unmounted lustre-client [ 933.717184] Key type lgssc unregistered [ 934.042977] LNet: 22459:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 934.055162] LNetError: 22459:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 934.067584] LNet: Removed LNI 192.168.206.23@tcp [ 934.741625] Key type .llcrypt unregistered [ 934.743724] Key type ._llcrypt unregistered [ 944.869628] Key type ._llcrypt registered [ 944.874761] Key type .llcrypt registered [ 946.284644] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 09:33:58 (1788442438) [ 948.940136] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 948.985834] alg: No test for adler32 (adler32-zlib) [ 950.194691] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 950.622455] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 952.351314] Key type lgssc registered [ 953.813323] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1002.230479] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1008.029453] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1027.521907] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1030.241902] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1036.412664] Lustre: Unmounted lustre-client [ 1064.367986] Key type lgssc unregistered [ 1064.595991] LNet: 25648:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1064.601670] LNetError: 25648:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1064.624492] LNet: Removed LNI 192.168.206.23@tcp [ 1065.316037] Key type .llcrypt unregistered [ 1065.317620] Key type ._llcrypt unregistered [ 1081.544669] Key type ._llcrypt registered [ 1081.549686] Key type .llcrypt registered [ 1083.170537] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 09:36:15 (1788442575) [ 1085.746285] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1085.836654] alg: No test for adler32 (adler32-zlib) [ 1086.893720] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 1087.171634] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 1088.871391] Key type lgssc registered [ 1090.132752] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1136.953512] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1142.657258] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1164.277769] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1166.125858] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1171.472790] Lustre: lustre-MDT0000-mdc-ffff93d5498f4000: Connection to lustre-MDT0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1181.672523] Lustre: lustre-MDT0001-mdc-ffff93d5498f4000: Connection to lustre-MDT0001 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1188.518282] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1197.023484] Lustre: 26607:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788442675/real 1788442675] req@00000000a3379d5d x1875317967820672/t0(0) o400->MGC192.168.206.123@tcp@192.168.206.123@tcp:26/25 lens 224/224 e 0 to 1 dl 1788442691 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1197.073583] LustreError: MGC192.168.206.123@tcp: Connection to MGS (at 192.168.206.123@tcp) was lost; in progress operations using this service will fail [ 1198.960622] Lustre: Unmounted lustre-client [ 1218.805607] Key type lgssc unregistered [ 1219.062992] LNet: 29301:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1219.072163] LNetError: 29301:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1219.101825] LNet: Removed LNI 192.168.206.23@tcp [ 1219.830457] Key type .llcrypt unregistered [ 1219.834154] Key type ._llcrypt unregistered [ 1235.767672] Key type ._llcrypt registered [ 1235.770167] Key type .llcrypt registered [ 1237.025633] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 09:38:49 (1788442729) [ 1239.269101] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1239.289729] alg: No test for adler32 (adler32-zlib) [ 1240.363437] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 1240.647956] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 1242.359202] Key type lgssc registered [ 1243.694631] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1294.376639] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1300.587344] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1321.594023] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1323.550647] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1335.087910] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1345.429193] Lustre: Unmounted lustre-client [ 1373.435478] Key type lgssc unregistered [ 1373.716818] LNet: 32915:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1373.725763] LNetError: 32915:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1373.756237] LNet: Removed LNI 192.168.206.23@tcp [ 1374.459461] Key type .llcrypt unregistered [ 1374.462416] Key type ._llcrypt unregistered [ 1392.951123] Key type ._llcrypt registered [ 1392.952937] Key type .llcrypt registered [ 1394.450290] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 09:41:27 (1788442887) [ 1397.606257] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1397.721596] alg: No test for adler32 (adler32-zlib) [ 1398.970603] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 1399.328332] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 1401.095639] Key type lgssc registered [ 1402.724150] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1455.085525] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1460.604170] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1483.346479] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1486.073336] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1490.180873] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1494.009165] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1505.627362] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-03 9h43m18s [ 1507.577643] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1509.864798] Lustre: lustre-MDT0000-mdc-ffff93d550e66800: Connection to lustre-MDT0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1517.358521] LustreError: 36703:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff93d550e66800: can't stat MDS #0: rc = -19 [ 1518.922881] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1527.283896] LustreError: MGC192.168.206.123@tcp: Connection to MGS (at 192.168.206.123@tcp) was lost; in progress operations using this service will fail [ 1527.306738] Lustre: Evicted from MGS (at 192.168.206.123@tcp) after server handle changed from 0x604519feab615fd6 to 0x604519feab6162a0 [ 1527.313188] Lustre: MGC192.168.206.123@tcp: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [ 1528.375147] LustreError: lustre-MDT0000-mdc-ffff93d550e66800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1528.396431] Lustre: lustre-MDT0000-mdc-ffff93d550e66800: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [ 1533.940837] Lustre: DEBUG MARKER: Wait for df (36703) ... [ 1535.890777] Lustre: DEBUG MARKER: done [ 1538.097567] Lustre: Unmounted lustre-client [ 1567.058407] Key type lgssc unregistered [ 1567.343638] LNet: 37723:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1567.376736] LNetError: 37723:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1567.411540] LNet: Removed LNI 192.168.206.23@tcp [ 1568.275176] Key type .llcrypt unregistered [ 1568.277978] Key type ._llcrypt unregistered [ 1601.232201] Key type ._llcrypt registered [ 1601.238401] Key type .llcrypt registered [ 1602.817995] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 09:44:55 (1788443095) [ 1605.780425] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1605.792326] alg: No test for adler32 (adler32-zlib) [ 1606.735467] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 1607.001986] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 1608.671176] Key type lgssc registered [ 1610.124144] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1663.589888] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1669.748245] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1691.538185] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1693.214849] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1697.680395] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-03 9h46m30s [ 1699.583671] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1706.913408] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1709.515492] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1730.016373] Lustre: 41874:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788443204/real 1788443204] req@00000000a879d886 x1875318513080960/t0(0) o101->lustre-MDT0000-mdc-ffff93d548769000@192.168.206.123@tcp:12/10 lens 576/1152 e 0 to 1 dl 1788443224 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1730.057502] Lustre: lustre-MDT0000-mdc-ffff93d548769000: Connection to lustre-MDT0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1730.105616] Lustre: lustre-MDT0000-mdc-ffff93d548769000: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [ 1751.213520] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1753.684829] Lustre: DEBUG MARKER: done [ 1757.074500] Lustre: Unmounted lustre-client [ 1783.377586] Key type lgssc unregistered [ 1783.639789] LNet: 42753:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1783.649691] LNetError: 42753:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1783.676415] LNet: Removed LNI 192.168.206.23@tcp [ 1784.340815] Key type .llcrypt unregistered [ 1784.344446] Key type ._llcrypt unregistered [ 1813.668651] Key type ._llcrypt registered [ 1813.676994] Key type .llcrypt registered [ 1815.053332] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 09:48:27 (1788443307) [ 1816.639450] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1818.244708] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 09:48:31 (1788443311) [ 1822.065144] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1822.102254] alg: No test for adler32 (adler32-zlib) [ 1823.133903] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 1823.359600] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 1825.009906] Key type lgssc registered [ 1826.251812] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1851.979800] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 09:49:04 (1788443344) [ 1884.019316] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1889.917988] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1910.969281] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1913.637408] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 1917.124562] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 1920.459174] Lustre: Unmounted lustre-client [ 1945.638397] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 1992.866520] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1998.289789] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1998.804293] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2002.432648] Lustre: Unmounted lustre-client [ 2075.073657] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2080.793704] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2081.608162] LustreError: 44182:0:(lmv_obd.c:211:lmv_notify()) activation of lustre-MDT0001_UUID failed: -22 [ 2081.705388] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2086.329855] Lustre: Unmounted lustre-client [ 2118.248177] Lustre: DEBUG MARKER: files compared the same [ 2143.369648] Key type lgssc unregistered [ 2143.631153] LNet: 50386:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2143.638820] LNetError: 50386:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2143.656290] LNet: Removed LNI 192.168.206.23@tcp [ 2144.129768] Key type .llcrypt unregistered [ 2144.131747] Key type ._llcrypt unregistered [ 2158.316555] Key type ._llcrypt registered [ 2158.320861] Key type .llcrypt registered [ 2159.597608] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 09:54:12 (1788443652) [ 2161.680737] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2161.712888] alg: No test for adler32 (adler32-zlib) [ 2162.929172] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 2163.144154] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 2164.775150] Key type lgssc registered [ 2165.954862] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2220.233946] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2225.986771] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2245.661631] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2248.479358] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2252.146201] Lustre: Unmounted lustre-client [ 2278.672880] Key type lgssc unregistered [ 2278.951689] LNet: 53972:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2278.959146] LNetError: 53972:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2278.974424] LNet: Removed LNI 192.168.206.23@tcp [ 2279.840227] Key type .llcrypt unregistered [ 2279.843226] Key type ._llcrypt unregistered [ 2294.595711] Key type ._llcrypt registered [ 2294.602157] Key type .llcrypt registered [ 2295.959311] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 09:56:28 (1788443788) [ 2298.111080] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2298.239992] alg: No test for adler32 (adler32-zlib) [ 2299.297824] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 2299.590336] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 2301.287207] Key type lgssc registered [ 2302.695922] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2384.775890] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2417.492231] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2423.250947] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2450.286847] Key type lgssc unregistered [ 2450.559180] LNet: 57459:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2450.569802] LNetError: 57459:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2450.603979] LNet: Removed LNI 192.168.206.23@tcp [ 2451.402638] Key type .llcrypt unregistered [ 2451.415757] Key type ._llcrypt unregistered [ 2472.670979] Key type ._llcrypt registered [ 2472.673348] Key type .llcrypt registered [ 2474.073983] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 09:59:26 (1788443966) [ 2477.991164] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2478.016111] alg: No test for adler32 (adler32-zlib) [ 2479.235262] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 2479.685885] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 2481.391214] Key type lgssc registered [ 2482.531236] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2563.445914] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2571.172657] Lustre: Unmounted lustre-client [ 2609.486343] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 10:01:41 (1788444101) [ 2730.259508] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2753.616901] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2761.197793] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2761.204170] LustreError: 63948:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff93d5501f1000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2761.221496] Lustre: 58444:0:(llite_lib.c:4340:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.206.123@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2771.578850] Lustre: Unmounted lustre-client [ 2817.030159] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 10:05:10 (1788444310) [ 2830.085269] Key type lgssc unregistered [ 2830.399697] LNet: 65163:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2830.411387] LNetError: 65163:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2830.435723] LNet: Removed LNI 192.168.206.23@tcp [ 2831.576064] Key type .llcrypt unregistered [ 2831.579147] Key type ._llcrypt unregistered [ 2846.855191] Key type ._llcrypt registered [ 2846.861675] Key type .llcrypt registered [ 2847.150866] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2847.165662] alg: No test for adler32 (adler32-zlib) [ 2848.348813] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 2848.840100] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 2850.576222] Key type lgssc registered [ 2852.284878] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2901.753755] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2907.666300] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2932.421863] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2934.237884] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 2938.487448] Lustre: Unmounted lustre-client [ 2961.257741] Key type lgssc unregistered [ 2961.546435] LNet: 68177:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2961.556390] LNetError: 68177:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2961.576459] LNet: Removed LNI 192.168.206.23@tcp [ 2962.262849] Key type .llcrypt unregistered [ 2962.271583] Key type ._llcrypt unregistered [ 2973.746212] Key type ._llcrypt registered [ 2973.753205] Key type .llcrypt registered [ 2974.238571] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2974.268219] alg: No test for adler32 (adler32-zlib) [ 2975.442424] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 2975.784875] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 2977.471320] Key type lgssc registered [ 2979.072813] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3085.056193] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3092.996567] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3117.709742] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3119.862974] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 3124.116883] Lustre: Unmounted lustre-client [ 3152.238584] Key type lgssc unregistered [ 3152.475471] LNet: 71613:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3152.483287] LNetError: 71613:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3152.501161] LNet: Removed LNI 192.168.206.23@tcp [ 3153.025694] Key type .llcrypt unregistered [ 3153.028038] Key type ._llcrypt unregistered [ 3167.792756] Key type ._llcrypt registered [ 3167.795375] Key type .llcrypt registered [ 3168.809860] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 10:11:01 (1788444661) [ 3171.026439] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3171.051848] alg: No test for adler32 (adler32-zlib) [ 3172.097121] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 3172.310986] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 3173.991259] Key type lgssc registered [ 3175.254919] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3223.506506] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3229.505901] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3251.870730] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3253.671225] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 3262.522891] Lustre: Unmounted lustre-client [ 3263.084983] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 3266.070253] Lustre: Unmounted lustre-client [ 3299.106838] Key type lgssc unregistered [ 3299.450957] LNet: 75301:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3299.456375] LNetError: 75301:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3300.519970] LNet: Removed LNI 192.168.206.23@tcp [ 3301.364646] Key type .llcrypt unregistered [ 3301.367940] Key type ._llcrypt unregistered [ 3315.308818] Key type ._llcrypt registered [ 3315.312419] Key type .llcrypt registered [ 3315.839893] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3315.856721] alg: No test for adler32 (adler32-zlib) [ 3317.155284] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 3317.346068] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 3319.015189] Key type lgssc registered [ 3320.474907] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3368.303774] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3373.782562] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3395.424442] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3397.249960] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 3403.065343] Lustre: Unmounted lustre-client [ 3433.711655] Key type lgssc unregistered [ 3434.051127] LNet: 78331:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3434.058409] LNetError: 78331:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3434.084251] LNet: Removed LNI 192.168.206.23@tcp [ 3435.046789] Key type .llcrypt unregistered [ 3435.048753] Key type ._llcrypt unregistered [ 3451.432176] Key type ._llcrypt registered [ 3451.434317] Key type .llcrypt registered [ 3452.734349] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 10:15:45 (1788444945) [ 3455.096170] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3455.220085] alg: No test for adler32 (adler32-zlib) [ 3456.231329] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 3456.412708] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 3458.071178] Key type lgssc registered [ 3459.196057] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3503.593601] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3509.378397] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3537.592617] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3539.333961] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 3547.572023] Lustre: lustre: root_squash is set to 0:0 [ 3553.859180] Lustre: lustre: nosquash_nids is cleared [ 3553.901495] Lustre: lustre: root_squash is set to 500:500 [ 3564.082134] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.206.23@tcp 192.168.0.[2,10]@tcp [ 3573.432435] Lustre: lustre: nosquash_nids set to 192.168.206.23/24@tcp [ 3577.034959] Lustre: Unmounted lustre-client [ 3611.376577] Key type lgssc unregistered [ 3611.686114] LNet: 82293:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3611.694413] LNetError: 82293:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3611.711325] LNet: Removed LNI 192.168.206.23@tcp [ 3612.393720] Key type .llcrypt unregistered [ 3612.395879] Key type ._llcrypt unregistered [ 3628.115538] Key type ._llcrypt registered [ 3628.117633] Key type .llcrypt registered [ 3629.342685] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 10:18:42 (1788445122) [ 3631.656935] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3633.555991] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 10:18:46 (1788445126) [ 3635.923764] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3635.953419] alg: No test for adler32 (adler32-zlib) [ 3637.202330] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 3637.384347] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 3638.999629] Key type lgssc registered [ 3640.210278] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3695.714815] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3700.772654] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3720.457136] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3722.037932] Lustre: lustre: root_squash is set to 500:500 [ 3722.077294] Lustre: lustre: nosquash_nids set to 192.168.206.23/24@tcp [ 3723.125382] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 3733.341656] Lustre: Unmounted lustre-client [ 3766.177824] Key type lgssc unregistered [ 3766.480081] LNet: 86255:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3766.487836] LNetError: 86255:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3766.520756] LNet: Removed LNI 192.168.206.23@tcp [ 3767.313982] Key type .llcrypt unregistered [ 3767.323371] Key type ._llcrypt unregistered [ 3780.002312] Key type ._llcrypt registered [ 3780.005641] Key type .llcrypt registered [ 3781.105000] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3782.924924] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 10:21:15 (1788445275) [ 3800.247537] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3800.304090] alg: No test for adler32 (adler32-zlib) [ 3801.304152] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 3801.553301] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 3803.239116] Key type lgssc registered [ 3804.298167] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3870.954418] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3877.382209] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3900.491249] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3977.287925] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3983.874469] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4005.785907] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4018.069585] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 4054.868941] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff93d545d66000.ost_server_uuid 50 [ 4056.842724] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff93d545d66000.ost_server_uuid in IDLE state after 0 sec [ 4057.913192] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 4061.641024] Lustre: Unmounted lustre-client [ 4064.516206] Lustre: Unmounted lustre-client [ 4109.784945] Key type lgssc unregistered [ 4110.176852] LNet: 93918:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4110.188485] LNetError: 93918:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4110.216350] LNet: Removed LNI 192.168.206.23@tcp [ 4111.071515] Key type .llcrypt unregistered [ 4111.077860] Key type ._llcrypt unregistered [ 4145.160462] Key type ._llcrypt registered [ 4145.162754] Key type .llcrypt registered [ 4146.686857] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 10:27:19 (1788445639) [ 4168.965227] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4169.135303] alg: No test for adler32 (adler32-zlib) [ 4170.323647] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 4170.692540] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 4172.468065] Key type lgssc registered [ 4173.876504] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4262.494828] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4268.666341] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4295.996057] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4298.728253] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 4320.159195] Lustre: 95292:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788445798/real 1788445798] req@00000000ebca783f x1875321200579840/t0(0) o400->lustre-OST0000-osc-ffff93d55866f000@192.168.206.123@tcp:28/4 lens 224/224 e 0 to 1 dl 1788445814 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4320.182471] Lustre: lustre-OST0000-osc-ffff93d55866f000: Connection to lustre-OST0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4325.279191] Lustre: 95292:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788445803/real 1788445803] req@000000007052b8d9 x1875321200580352/t0(0) o400->lustre-OST0000-osc-ffff93d55866f000@192.168.206.123@tcp:28/4 lens 224/224 e 0 to 1 dl 1788445819 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4330.015506] Lustre: 95293:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788445808/real 1788445808] req@000000009598c5a3 x1875321200580864/t0(0) o400->lustre-OST0000-osc-ffff93d55866f000@192.168.206.123@tcp:28/4 lens 224/224 e 0 to 1 dl 1788445824 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4330.486129] Lustre: lustre-MDT0000-mdc-ffff93d55866f000: Connection to lustre-MDT0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4330.526117] Lustre: lustre-OST0000-osc-ffff93d55866f000: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [ 4335.135128] Lustre: 95293:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788445813/real 1788445813] req@000000001b9c0eb4 x1875321200581376/t0(0) o400->lustre-OST0000-osc-ffff93d55866f000@192.168.206.123@tcp:28/4 lens 224/224 e 0 to 1 dl 1788445829 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4345.824204] Lustre: 95292:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788445824/real 1788445824] req@00000000ebca783f x1875321200582784/t0(0) o400->MGC192.168.206.123@tcp@192.168.206.123@tcp:26/25 lens 224/224 e 0 to 1 dl 1788445840 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4345.851771] LustreError: MGC192.168.206.123@tcp: Connection to MGS (at 192.168.206.123@tcp) was lost; in progress operations using this service will fail [ 4356.086785] Lustre: Evicted from MGS (at 192.168.206.123@tcp) after server handle changed from 0x56d7f86690c6eea7 to 0x56d7f86690c6f036 [ 4356.105390] Lustre: MGC192.168.206.123@tcp: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [ 4363.141798] Lustre: lustre-MDT0000-mdc-ffff93d55866f000: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [ 4368.234369] Lustre: Unmounted lustre-client [ 4396.481440] Key type lgssc unregistered [ 4396.745655] LNet: 99595:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4396.759587] LNetError: 99595:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4397.798435] LNet: Removed LNI 192.168.206.23@tcp [ 4398.814148] Key type .llcrypt unregistered [ 4398.818361] Key type ._llcrypt unregistered [ 4415.038704] Key type ._llcrypt registered [ 4415.041762] Key type .llcrypt registered [ 4416.388820] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 10:31:49 (1788445909) [ 4431.432765] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4431.468102] alg: No test for adler32 (adler32-zlib) [ 4432.606879] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 4432.867298] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 4434.607182] Key type lgssc registered [ 4436.021934] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4475.338240] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4572.111331] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4577.927096] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4599.983149] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4601.546506] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 4603.842494] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4605.411169] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 10:34:58 (1788446098) [ 4840.124562] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 4850.482549] Lustre: Unmounted lustre-client [ 4966.451812] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4971.358059] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4991.723596] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5039.319547] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:42:12 (1788446532) [ 5126.069424] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5131.727300] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5151.771929] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5152.281663] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 5155.745779] Lustre: Unmounted lustre-client [ 5184.904631] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 10:44:37 (1788446677) [ 5274.394529] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5279.614498] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5300.713930] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5301.341163] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 5304.945682] Lustre: Unmounted lustre-client [ 5331.467306] Key type lgssc unregistered [ 5331.693396] LNet: 122607:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5331.719811] LNetError: 122607:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5331.737365] LNet: Removed LNI 192.168.206.23@tcp [ 5332.623908] Key type .llcrypt unregistered [ 5332.626745] Key type ._llcrypt unregistered [ 5350.253704] Key type ._llcrypt registered [ 5350.255756] Key type .llcrypt registered [ 5351.371630] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 10:47:24 (1788446844) [ 5353.342186] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5353.374968] alg: No test for adler32 (adler32-zlib) [ 5354.382268] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 5354.614341] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 5356.271962] Key type lgssc registered [ 5357.321395] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5403.123428] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5408.848764] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5427.857201] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5430.447922] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 5443.688130] Lustre: Unmounted lustre-client [ 5480.981619] Key type lgssc unregistered [ 5481.230734] LNet: 126199:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5481.238817] LNetError: 126199:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5481.259451] LNet: Removed LNI 192.168.206.23@tcp [ 5481.872619] Key type .llcrypt unregistered [ 5481.882827] Key type ._llcrypt unregistered [ 5495.786970] Key type ._llcrypt registered [ 5495.790460] Key type .llcrypt registered [ 5496.848270] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 10:49:49 (1788446989) [ 5498.813549] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5498.846481] alg: No test for adler32 (adler32-zlib) [ 5499.911720] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 5500.185553] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 5501.863231] Key type lgssc registered [ 5503.374259] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5551.605567] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5557.503594] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5576.898232] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5578.613312] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 5594.085245] Lustre: lustre-OST0000-osc-ffff93d545d60800: Connection to lustre-OST0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5604.105284] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff93d545d60800.ost_server_uuid 50 [ 5605.620730] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5616.544807] Lustre: Unmounted lustre-client [ 5637.916028] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 10:52:10 (1788447130) [ 5668.939683] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5674.259276] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5693.539585] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5715.829698] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5716.478682] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 5721.579973] Lustre: lustre-OST0000-osc-ffff93d546d7f000: Connection to lustre-OST0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5756.155960] Lustre: Unmounted lustre-client [ 5797.815761] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 10:54:50 (1788447290) [ 5829.149588] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5835.091732] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5855.717076] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5877.073925] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5877.623661] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 5882.870761] Lustre: lustre-OST0000-osc-ffff93d5479c8800: Connection to lustre-OST0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5899.615185] Lustre: Unmounted lustre-client [ 5956.530617] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 10:57:29 (1788447449) [ 6040.785406] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6047.297888] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6068.867935] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6143.368539] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6149.311786] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6169.372398] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6198.721620] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 6238.107530] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6244.873082] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 5 sec [ 6247.001403] Lustre: Unmounted lustre-client [ 6278.410509] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 11:02:51 (1788447771) [ 6316.066695] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6322.516869] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6344.184406] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6377.512962] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6407.306574] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 6449.584614] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6451.120199] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6453.738511] Lustre: lustre-OST0001-osc-ffff93d545ce3000: Connection to lustre-OST0001 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6463.431790] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6473.810860] Lustre: Unmounted lustre-client [ 6529.665658] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 11:07:01 (1788448021) [ 6566.896413] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6572.960716] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6593.940653] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6594.872651] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 6623.637232] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6625.006917] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6640.943666] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff93d54638a000.ost_server_uuid 50 [ 6642.729332] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff93d54638a000.ost_server_uuid in IDLE state after 0 sec [ 6646.392757] Lustre: Unmounted lustre-client [ 6646.821054] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6646.827134] Lustre: Skipped 3 previous similar messages [ 6646.913635] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 6648.248967] LustreError: 149645:0:(sec.c:403:import_sec_validate_get()) import 000000005788ebda (NEW) with no sec [ 6714.048601] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 11:10:06 (1788448206) [ 6743.896382] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6749.209533] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6770.313427] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6792.256422] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6792.845457] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 6793.064573] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 6805.064990] Lustre: Unmounted lustre-client [ 6805.066633] Lustre: Skipped 1 previous similar message [ 6844.336345] Key type lgssc unregistered [ 6844.664077] LNet: 153051:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 6844.669107] LNetError: 153051:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 6844.703484] LNet: Removed LNI 192.168.206.23@tcp [ 6845.493477] Key type .llcrypt unregistered [ 6845.496496] Key type ._llcrypt unregistered [ 6862.611904] Key type ._llcrypt registered [ 6862.614255] Key type .llcrypt registered [ 6864.238195] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 11:12:36 (1788448356) [ 6865.803671] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 6865.832951] alg: No test for adler32 (adler32-zlib) [ 6866.952905] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 6867.301716] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 6869.023473] Key type lgssc registered [ 6870.342544] Lustre: Echo OBD driver; http://www.lustre.org/ [ 6930.696460] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6937.460397] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6961.993925] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6983.212186] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6984.690883] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 6985.891674] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 6989.971472] LustreError: lustre-MDT0001-mdc-ffff93d54876e000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 6990.002316] Lustre: lustre-MDT0001-mdc-ffff93d54876e000: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [ 6996.247619] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6997.515058] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7016.445402] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7025.926283] Lustre: Unmounted lustre-client [ 7052.922441] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 11:15:45 (1788448545) [ 7153.962959] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7160.232125] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7183.682524] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7184.208173] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 7216.240035] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7218.314322] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7230.607510] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7240.967917] Lustre: Unmounted lustre-client [ 7285.619493] Key type lgssc unregistered [ 7285.987915] LNet: 162652:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7285.999514] LNetError: 162652:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7286.049861] LNet: Removed LNI 192.168.206.23@tcp [ 7286.879520] Key type .llcrypt unregistered [ 7286.882868] Key type ._llcrypt unregistered [ 7323.165768] Key type ._llcrypt registered [ 7323.168840] Key type .llcrypt registered [ 7324.840090] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 11:20:17 (1788448817) [ 7328.033641] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7328.077498] alg: No test for adler32 (adler32-zlib) [ 7329.316852] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 7329.757388] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 7331.495196] Key type lgssc registered [ 7332.738846] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7384.539950] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7389.802353] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7410.241911] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7411.891063] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 7457.934104] Lustre: Unmounted lustre-client [ 7497.114928] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7497.825704] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 7533.364309] Lustre: Unmounted lustre-client [ 7561.031416] Key type lgssc unregistered [ 7561.442750] LNet: 167107:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7561.456629] LNetError: 167107:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7561.480079] LNet: Removed LNI 192.168.206.23@tcp [ 7562.565645] Key type .llcrypt unregistered [ 7562.567538] Key type ._llcrypt unregistered [ 7578.477411] Key type ._llcrypt registered [ 7578.486089] Key type .llcrypt registered [ 7579.945539] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 11:24:32 (1788449072) [ 7582.408532] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7582.510898] alg: No test for adler32 (adler32-zlib) [ 7583.678248] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 7583.944479] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 7585.655179] Key type lgssc registered [ 7586.909920] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7642.293987] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7649.922653] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7672.833719] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7684.159586] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 7702.021288] Lustre: Unmounted lustre-client [ 7729.345366] Key type lgssc unregistered [ 7729.587888] LNet: 170869:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7729.598971] LNetError: 170869:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7729.632126] LNet: Removed LNI 192.168.206.23@tcp [ 7730.541922] Key type .llcrypt unregistered [ 7730.547917] Key type ._llcrypt unregistered [ 7741.839000] Key type ._llcrypt registered [ 7741.845223] Key type .llcrypt registered [ 7742.057954] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7742.084843] alg: No test for adler32 (adler32-zlib) [ 7743.136441] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 7743.383491] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 7745.055166] Key type lgssc registered [ 7746.188649] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7791.677088] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7798.716896] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7823.466732] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7826.100166] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 7832.236626] Lustre: Unmounted lustre-client [ 7856.479736] Key type lgssc unregistered [ 7856.697884] LNet: 173936:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7856.711902] LNetError: 173936:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7856.730521] LNet: Removed LNI 192.168.206.23@tcp [ 7857.328387] Key type .llcrypt unregistered [ 7857.330437] Key type ._llcrypt unregistered [ 7871.583044] Key type ._llcrypt registered [ 7871.585946] Key type .llcrypt registered [ 7872.855495] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 11:29:25 (1788449365) [ 7875.295926] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7875.314202] alg: No test for adler32 (adler32-zlib) [ 7876.329232] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 7876.586683] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 7878.319219] Key type lgssc registered [ 7879.304658] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7933.754827] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7939.236520] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7960.482965] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7963.184632] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 7985.497130] Lustre: Unmounted lustre-client [ 8015.424301] Key type lgssc unregistered [ 8015.665846] LNet: 177693:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8015.671392] LNetError: 177693:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8015.693518] LNet: Removed LNI 192.168.206.23@tcp [ 8016.488781] Key type .llcrypt unregistered [ 8016.492087] Key type ._llcrypt unregistered [ 8027.293854] Key type ._llcrypt registered [ 8027.297410] Key type .llcrypt registered [ 8027.837337] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8027.856756] alg: No test for adler32 (adler32-zlib) [ 8029.097981] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 8029.480790] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 8031.191437] Key type lgssc registered [ 8032.264908] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8082.135978] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8087.587042] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8109.324751] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8111.273501] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 8120.989209] Lustre: Unmounted lustre-client [ 8156.234733] Key type lgssc unregistered [ 8156.496752] LNet: 180763:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8156.507041] LNetError: 180763:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8156.518942] LNet: Removed LNI 192.168.206.23@tcp [ 8157.082272] Key type .llcrypt unregistered [ 8157.088077] Key type ._llcrypt unregistered [ 8171.217285] Key type ._llcrypt registered [ 8171.221188] Key type .llcrypt registered [ 8172.415080] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 11:34:25 (1788449665) [ 8193.169871] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8193.326358] alg: No test for adler32 (adler32-zlib) [ 8194.421899] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 8194.703394] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 8196.376265] Key type lgssc registered [ 8197.513367] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8278.921872] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8285.595968] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8308.557174] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8347.274719] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 11:37:20 (1788449840) [ 8380.017985] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8385.874480] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8408.838285] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8410.597182] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 8419.899338] Lustre: Unmounted lustre-client [ 8449.521022] Key type lgssc unregistered [ 8449.885616] LNet: 187861:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8449.898537] LNetError: 187861:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8449.922129] LNet: Removed LNI 192.168.206.23@tcp [ 8450.817162] Key type .llcrypt unregistered [ 8450.820802] Key type ._llcrypt unregistered [ 8468.004877] Key type ._llcrypt registered [ 8468.007543] Key type .llcrypt registered [ 8469.596188] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8471.310410] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 11:39:24 (1788449964) [ 8488.626863] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8488.693428] alg: No test for adler32 (adler32-zlib) [ 8489.945444] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 8490.253386] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 8491.927208] Key type lgssc registered [ 8493.077951] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8590.584409] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8596.568032] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8619.008830] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8640.700582] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8643.295383] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 8665.946402] Lustre: Unmounted lustre-client [ 8803.248972] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8809.882067] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8833.856537] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8871.913529] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 11:46:04 (1788450364) [ 8873.330208] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8875.012129] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 11:46:07 (1788450367) [ 8966.561749] Key type lgssc unregistered [ 8966.791078] LNet: 199299:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8966.799343] LNetError: 199299:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8966.824554] LNet: Removed LNI 192.168.206.23@tcp [ 8967.650581] Key type .llcrypt unregistered [ 8967.653823] Key type ._llcrypt unregistered [ 8983.866631] Key type ._llcrypt registered [ 8983.868196] Key type .llcrypt registered [ 8985.223289] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 11:47:57 (1788450477) [ 9028.075868] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9028.091982] alg: No test for adler32 (adler32-zlib) [ 9029.241519] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 9029.585266] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 9031.255179] Key type lgssc registered [ 9032.551445] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9082.761498] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9088.478831] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9122.512804] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9150.607505] Key type lgssc unregistered [ 9150.932762] LNet: 203033:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9150.943776] LNetError: 203033:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9150.955049] LNet: Removed LNI 192.168.206.23@tcp [ 9151.828948] Key type .llcrypt unregistered [ 9151.832573] Key type ._llcrypt unregistered [ 9168.155835] Key type ._llcrypt registered [ 9168.157790] Key type .llcrypt registered [ 9169.273385] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 11:51:02 (1788450662) [ 9172.813251] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9172.829924] alg: No test for adler32 (adler32-zlib) [ 9174.053451] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 9174.314881] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 9176.023233] Key type lgssc registered [ 9177.134578] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9233.611923] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9239.528475] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9263.612428] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9274.459305] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [ 9284.602216] Lustre: lustre-MDT0000-mdc-ffff93d545ce7800: Connection to lustre-MDT0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9294.820418] Lustre: lustre-MDT0001-mdc-ffff93d545ce7800: Connection to lustre-MDT0001 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9304.991777] Lustre: 204025:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788450783/real 1788450783] req@00000000a64a1b6d x1875326447731200/t0(0) o400->MGC192.168.206.123@tcp@192.168.206.123@tcp:26/25 lens 224/224 e 0 to 1 dl 1788450799 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9305.018572] LustreError: MGC192.168.206.123@tcp: Connection to MGS (at 192.168.206.123@tcp) was lost; in progress operations using this service will fail [ 9330.676510] Lustre: Evicted from MGS (at 192.168.206.123@tcp) after server handle changed from 0xab7ef360378934d3 to 0xab7ef3603789519e [ 9330.692559] Lustre: MGC192.168.206.123@tcp: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [ 9339.886216] LustreError: lustre-MDT0000-mdc-ffff93d545ce7800: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9339.944277] Lustre: lustre-MDT0000-mdc-ffff93d545ce7800: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [ 9348.385691] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9350.275679] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9356.921129] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9358.868386] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9362.911085] Lustre: Unmounted lustre-client [ 9399.788907] Key type lgssc unregistered [ 9400.083194] LNet: 207986:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9400.092971] LNetError: 207986:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9400.108739] LNet: Removed LNI 192.168.206.23@tcp [ 9400.965837] Key type .llcrypt unregistered [ 9400.970795] Key type ._llcrypt unregistered [ 9418.299204] Key type ._llcrypt registered [ 9418.302330] Key type .llcrypt registered [ 9420.142232] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 11:55:12 (1788450912) [ 9423.545215] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9423.687904] alg: No test for adler32 (adler32-zlib) [ 9424.841491] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 9425.155491] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 9426.852171] Key type lgssc registered [ 9428.181520] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9484.204064] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9491.334059] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9558.358392] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9567.031394] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9607.189448] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9632.944895] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9691.960827] Key type lgssc unregistered [ 9692.222858] LNet: 213291:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9692.232941] LNetError: 213291:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9692.261393] LNet: Removed LNI 192.168.206.23@tcp [ 9693.009092] Key type .llcrypt unregistered [ 9693.012576] Key type ._llcrypt unregistered [ 9740.054582] Key type ._llcrypt registered [ 9740.063069] Key type .llcrypt registered [ 9741.465417] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 12:00:34 (1788451234) [ 9780.193727] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9780.203433] alg: No test for adler32 (adler32-zlib) [ 9781.300743] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [ 9781.614072] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [ 9783.295149] Key type lgssc registered [ 9784.663414] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9869.345244] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9875.721173] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9900.700098] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9941.947730] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 12:03:54 (1788451434) [ 9949.176647] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 12:04:02 (1788451442) [ 9985.650270] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9992.164221] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10014.739336] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10017.354977] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10023.028850] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [10025.339790] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [10027.480199] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [10029.662829] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [10032.618575] Lustre: lustre-MDT0000-mdc-ffff93d55063c000: Connection to lustre-MDT0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [10047.967305] Lustre: 215201:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788451526/real 1788451526] req@00000000609ab8f3 x1875327084144512/t0(0) o400->MGC192.168.206.123@tcp@192.168.206.123@tcp:26/25 lens 224/224 e 0 to 1 dl 1788451542 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10047.996364] LustreError: MGC192.168.206.123@tcp: Connection to MGS (at 192.168.206.123@tcp) was lost; in progress operations using this service will fail [10058.227461] Lustre: Evicted from MGS (at 192.168.206.123@tcp) after server handle changed from 0xb3ba7d8e1c8c604d to 0xb3ba7d8e1c8c6229 [10058.251554] Lustre: MGC192.168.206.123@tcp: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [10063.771303] Lustre: lustre-MDT0000-mdc-ffff93d55063c000: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [10071.484488] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10073.042659] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10076.595581] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [10078.692704] Lustre: lustre-MDT0000-mdc-ffff93d55063c000: Connection to lustre-MDT0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [10094.047271] Lustre: 215203:0:(client.c:2490:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1788451572/real 1788451572] req@00000000b2583e3f x1875327084153344/t0(0) o400->MGC192.168.206.123@tcp@192.168.206.123@tcp:26/25 lens 224/224 e 0 to 1 dl 1788451588 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [10094.071649] LustreError: MGC192.168.206.123@tcp: Connection to MGS (at 192.168.206.123@tcp) was lost; in progress operations using this service will fail [10102.749434] Lustre: lustre-MDT0000-mdc-ffff93d55063c000: Connection restored to 192.168.206.123@tcp (at 192.168.206.123@tcp) [10103.796787] Lustre: Evicted from MGS (at 192.168.206.123@tcp) after server handle changed from 0xb3ba7d8e1c8c6229 to 0xb3ba7d8e1c8c6770 [10110.952742] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10112.352384] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [10116.113566] Lustre: Unmounted lustre-client [10183.029887] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10189.049854] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10210.077976] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10210.632465] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10217.910803] Lustre: Unmounted lustre-client [10241.355573] Key type lgssc unregistered [10241.640261] LNet: 225792:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10241.651317] LNetError: 225792:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10241.671951] LNet: Removed LNI 192.168.206.23@tcp [10242.573694] Key type .llcrypt unregistered [10242.579911] Key type ._llcrypt unregistered [10258.924924] Key type ._llcrypt registered [10258.928871] Key type .llcrypt registered [10260.410264] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 12:09:13 (1788451753) [10264.637450] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10264.707443] alg: No test for adler32 (adler32-zlib) [10265.714079] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [10266.012322] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [10267.736572] Key type lgssc registered [10268.935451] Lustre: Echo OBD driver; http://www.lustre.org/ [10317.977553] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10323.715393] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10344.842060] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10346.556564] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10352.501233] Lustre: Unmounted lustre-client [10423.461496] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10429.136701] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10448.611524] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10449.137221] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10459.327225] Lustre: Unmounted lustre-client [10524.501936] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10529.572070] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10547.969321] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10548.484242] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10550.786919] Lustre: Unmounted lustre-client [10584.928625] Key type lgssc unregistered [10585.122602] LNet: 232848:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10585.135130] LNetError: 232848:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10585.156104] LNet: Removed LNI 192.168.206.23@tcp [10585.785558] Key type .llcrypt unregistered [10585.788758] Key type ._llcrypt unregistered [10600.595911] Key type ._llcrypt registered [10600.597779] Key type .llcrypt registered [10602.037480] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 12:14:54 (1788452094) [10605.127256] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10605.173361] alg: No test for adler32 (adler32-zlib) [10606.287721] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [10606.555604] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [10608.263269] Key type lgssc registered [10609.425795] Lustre: Echo OBD driver; http://www.lustre.org/ [10652.539439] Key type lgssc unregistered [10652.778588] LNet: 235172:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10652.785935] LNetError: 235172:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10652.799428] LNet: Removed LNI 192.168.206.23@tcp [10653.286639] Key type .llcrypt unregistered [10653.288460] Key type ._llcrypt unregistered [10684.697144] Key type ._llcrypt registered [10684.708379] Key type .llcrypt registered [10685.067895] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10685.088853] alg: No test for adler32 (adler32-zlib) [10686.200172] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [10686.476919] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [10688.143636] Key type lgssc registered [10689.200569] Lustre: Echo OBD driver; http://www.lustre.org/ [10761.245606] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10768.662056] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10791.432662] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10827.805753] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10829.104442] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 12:18:42 (1788452322) [10858.982557] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10863.615462] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10881.736639] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10900.657824] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10902.152551] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [10907.630542] Lustre: lustre-OST0001-osc-ffff93d550541000: Connection to lustre-OST0001 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [10912.673227] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10922.981855] Lustre: Unmounted lustre-client [10961.686774] Key type lgssc unregistered [10961.878907] LNet: 242288:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10961.883754] LNetError: 242288:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10961.895303] LNet: Removed LNI 192.168.206.23@tcp [10962.382230] Key type .llcrypt unregistered [10962.387980] Key type ._llcrypt unregistered [10986.253630] Key type ._llcrypt registered [10986.255864] Key type .llcrypt registered [10987.349786] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 12:21:20 (1788452480) [10997.730646] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10997.836856] alg: No test for adler32 (adler32-zlib) [10998.866408] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [10999.094846] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [11000.791369] Key type lgssc registered [11001.716889] Lustre: Echo OBD driver; http://www.lustre.org/ [11045.230466] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11050.942280] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11071.938949] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 12:22:44 (1788452564) [11101.954755] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11106.056556] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11122.993829] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11125.335698] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [11136.517531] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [11140.144100] Lustre: Unmounted lustre-client [11235.244417] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11241.132593] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11292.518716] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11293.099645] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [11295.055641] Lustre: Unmounted lustre-client [11324.589717] Key type lgssc unregistered [11325.060169] LNet: 249990:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11325.090698] LNetError: 249990:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11325.137174] LNet: Removed LNI 192.168.206.23@tcp [11326.095586] Key type .llcrypt unregistered [11326.103043] Key type ._llcrypt unregistered [11356.339640] Key type ._llcrypt registered [11356.343396] Key type .llcrypt registered [11356.882980] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11356.924448] alg: No test for adler32 (adler32-zlib) [11358.261347] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [11358.820114] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [11360.591175] Key type lgssc registered [11362.126497] Lustre: Echo OBD driver; http://www.lustre.org/ [11439.257834] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11444.141259] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11464.375541] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11503.974281] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [11505.712180] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 12:29:58 (1788452998) [11538.775566] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11544.900945] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11568.805519] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11574.074605] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [11576.512276] Lustre: Unmounted lustre-client [11610.630434] Key type lgssc unregistered [11610.834776] LNet: 256623:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11610.841920] LNetError: 256623:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11610.877181] LNet: Removed LNI 192.168.206.23@tcp [11611.501987] Key type .llcrypt unregistered [11611.508839] Key type ._llcrypt unregistered [11625.631169] Key type ._llcrypt registered [11625.633215] Key type .llcrypt registered [11626.811548] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [11628.277650] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 12:32:01 (1788453121) [11637.191395] Key type .llcrypt unregistered [11637.194861] Key type ._llcrypt unregistered [11644.772262] Key type ._llcrypt registered [11644.774419] Key type .llcrypt registered [11645.311340] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11645.329353] alg: No test for adler32 (adler32-zlib) [11646.378029] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [11646.669588] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [11648.343267] Key type lgssc registered [11649.554604] Lustre: Echo OBD driver; http://www.lustre.org/ [11705.529190] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11721.425053] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [11724.491674] Lustre: Unmounted lustre-client [11752.139121] Key type lgssc unregistered [11752.519794] LNet: 260079:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11752.527805] LNetError: 260079:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11752.559269] LNet: Removed LNI 192.168.206.23@tcp [11753.261809] Key type .llcrypt unregistered [11753.264584] Key type ._llcrypt unregistered [11770.545653] Key type ._llcrypt registered [11770.547332] Key type .llcrypt registered [11772.153706] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 12:34:24 (1788453264) [11774.574878] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11774.721477] alg: No test for adler32 (adler32-zlib) [11775.981676] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [11776.273333] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [11777.983226] Key type lgssc registered [11779.334756] Lustre: Echo OBD driver; http://www.lustre.org/ [11863.328868] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11897.069913] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11903.182969] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11906.256485] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [11909.836895] Lustre: Unmounted lustre-client [11945.104990] Key type lgssc unregistered [11945.473830] LNet: 263623:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11945.486068] LNetError: 263623:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11945.510232] LNet: Removed LNI 192.168.206.23@tcp [11946.376823] Key type .llcrypt unregistered [11946.381084] Key type ._llcrypt unregistered [11963.699824] Key type ._llcrypt registered [11963.702297] Key type .llcrypt registered [11965.485393] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 12:37:37 (1788453457) [11968.100299] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11968.154563] alg: No test for adler32 (adler32-zlib) [11969.445612] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [11969.923451] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [11971.752451] Key type lgssc registered [11973.053609] Lustre: Echo OBD driver; http://www.lustre.org/ [12023.225515] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12029.450811] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12050.087436] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12053.021579] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [12058.094720] Lustre: lustre-MDT0000-mdc-ffff93d549f5d800: Connection to lustre-MDT0000 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [12063.239571] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12063.295539] LustreError: 266780:0:(file.c:6154:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [12063.776371] LustreError: MGC192.168.206.123@tcp: Connection to MGS (at 192.168.206.123@tcp) was lost; in progress operations using this service will fail [12063.843552] Lustre: Unmounted lustre-client [12082.687945] Key type lgssc unregistered [12082.965256] LNet: 267197:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12082.980560] LNetError: 267197:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12082.994748] LNet: Removed LNI 192.168.206.23@tcp [12083.466041] Key type .llcrypt unregistered [12083.469630] Key type ._llcrypt unregistered [12102.293536] Key type ._llcrypt registered [12102.295314] Key type .llcrypt registered [12104.113539] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 12:39:56 (1788453596) [12107.010087] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12107.046085] alg: No test for adler32 (adler32-zlib) [12108.314970] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [12108.749839] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [12110.503187] Key type lgssc registered [12111.991614] Lustre: Echo OBD driver; http://www.lustre.org/ [12164.311425] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12170.703280] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12195.088536] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12196.826210] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [12207.926539] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [12210.732179] Lustre: Unmounted lustre-client [12233.965418] Key type lgssc unregistered [12234.225463] LNet: 270778:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12234.233942] LNetError: 270778:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12235.315856] LNet: Removed LNI 192.168.206.23@tcp [12236.147610] Key type .llcrypt unregistered [12236.153116] Key type ._llcrypt unregistered [12253.821928] Key type ._llcrypt registered [12253.823390] Key type .llcrypt registered [12255.187378] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 12:42:27 (1788453747) [12272.712237] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12272.734388] alg: No test for adler32 (adler32-zlib) [12273.886415] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [12274.159928] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [12275.847214] Key type lgssc registered [12277.193498] Lustre: Echo OBD driver; http://www.lustre.org/ [12386.201314] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12388.988065] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [12435.950097] Lustre: lustre-MDT0001-mdc-ffff93d5478dd800: Connection to lustre-MDT0001 (at 192.168.206.123@tcp) was lost; in progress operations using this service will wait for recovery to complete [12444.148553] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [12454.500023] Lustre: Unmounted lustre-client [12480.834305] Key type lgssc unregistered [12481.137989] LNet: 276563:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12481.159559] LNetError: 276563:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12481.193258] LNet: Removed LNI 192.168.206.23@tcp [12481.979875] Key type .llcrypt unregistered [12481.982064] Key type ._llcrypt unregistered [12497.780968] Key type ._llcrypt registered [12497.788896] Key type .llcrypt registered [12499.276569] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 12:46:31 (1788453991) [12501.131264] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [12503.083497] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 12:46:35 (1788453995) [12505.636833] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [12507.507883] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 12:46:40 (1788454000) [12509.503305] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [12511.276752] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 12:46:44 (1788454004) [12512.937736] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [12515.118707] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 12:46:47 (1788454007) [12516.985743] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [12518.714152] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 12:46:51 (1788454011) [12527.860407] Key type .llcrypt unregistered [12527.863713] Key type ._llcrypt unregistered [12534.654619] Key type ._llcrypt registered [12534.659111] Key type .llcrypt registered [12535.482822] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12535.521700] alg: No test for adler32 (adler32-zlib) [12536.768105] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [12537.372963] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [12539.399497] Key type lgssc registered [12540.798516] Lustre: Echo OBD driver; http://www.lustre.org/ [12623.646878] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12629.415243] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12655.287856] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12656.846938] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [12659.610806] Lustre: Unmounted lustre-client [12704.036865] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 12:49:55 (1788454195) [12739.993978] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12746.049918] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12782.822188] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12788.800573] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [12791.188311] Lustre: Unmounted lustre-client [12836.789125] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 12:52:09 (1788454329) [12838.495218] LNet: 1 local NIs in recovery (showing 1): 192.168.206.23@tcp [13495.018430] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13501.089838] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13537.536519] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13644.987787] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 13:05:37 (1788455137) [13659.134836] Key type lgssc unregistered [13659.538920] LNet: 290111:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13659.552949] LNetError: 290111:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13659.581407] LNet: Removed LNI 192.168.206.23@tcp [13660.603771] Key type .llcrypt unregistered [13660.606211] Key type ._llcrypt unregistered [13786.228762] Key type ._llcrypt registered [13786.234275] Key type .llcrypt registered [13787.063089] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [13787.088541] alg: No test for adler32 (adler32-zlib) [13788.413517] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [13788.866738] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [13790.623375] Key type lgssc registered [13792.541927] Lustre: Echo OBD driver; http://www.lustre.org/ [13899.044617] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [13906.751772] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [13932.342253] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13977.273745] Key type lgssc unregistered [13977.556979] LNet: 293815:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13977.578373] LNetError: 293815:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13977.595188] LNet: Removed LNI 192.168.206.23@tcp [13978.344834] Key type .llcrypt unregistered [13978.349798] Key type ._llcrypt unregistered [14019.073159] Key type ._llcrypt registered [14019.079925] Key type .llcrypt registered [14020.656910] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 13:11:53 (1788455513) [14044.432994] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14044.587554] alg: No test for adler32 (adler32-zlib) [14045.841495] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14046.183873] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [14047.872661] Key type lgssc registered [14049.217734] Lustre: Echo OBD driver; http://www.lustre.org/ [14105.019574] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 13:13:17 (1788455597) [14117.416445] Key type lgssc unregistered [14117.644792] LNet: 297373:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14117.652874] LNetError: 297373:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14117.669921] LNet: Removed LNI 192.168.206.23@tcp [14118.382990] Key type .llcrypt unregistered [14118.384973] Key type ._llcrypt unregistered [14130.933434] Key type ._llcrypt registered [14130.939921] Key type .llcrypt registered [14131.389627] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14131.401206] alg: No test for adler32 (adler32-zlib) [14132.538502] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14132.819880] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [14134.486906] Key type lgssc registered [14135.834752] Lustre: Echo OBD driver; http://www.lustre.org/ [14189.736178] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14196.443276] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14224.683722] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14547.075266] LNet: Added LNI 192.168.206.23@tcp50 [8/256/0/180] [14549.211557] LNet: Removed LNI 192.168.206.23@tcp [14551.537246] Lustre: 301789:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff93d5477ab000: config has no valid NIDs, force dynamic NIDs [14552.803622] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [14552.982850] Lustre: Unmounted lustre-client [14555.836221] Key type lgssc unregistered [14556.225716] LNet: 302053:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14556.232484] LNetError: 302053:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14556.259666] LNet: Removed LNI 192.168.206.23@tcp50 [14556.950725] Key type .llcrypt unregistered [14556.955442] Key type ._llcrypt unregistered [14577.461803] Key type ._llcrypt registered [14577.482395] Key type .llcrypt registered [14577.968455] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [14578.002146] alg: No test for adler32 (adler32-zlib) [14579.481373] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14579.689509] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [14581.455174] Key type lgssc registered [14582.976945] Lustre: Echo OBD driver; http://www.lustre.org/ [14650.694762] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14656.963270] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14665.061575] LNet: Added LNI 192.168.206.23@tcp50 [8/256/0/180] [14665.963983] LNet: Removed LNI 192.168.206.23@tcp [14667.247547] Lustre: 304748:0:(ldlm_lib.c:563:client_obd_setup()) lustre-MDT0000-mdc-ffff93d5481bc000: config has no valid NIDs, force dynamic NIDs [14668.471545] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [14668.981183] Lustre: Unmounted lustre-client [14712.414458] Key type lgssc unregistered [14712.779325] LNet: 305623:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14712.786033] LNetError: 305623:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14712.806059] LNet: Removed LNI 192.168.206.23@tcp50 [14713.417739] Key type .llcrypt unregistered [14713.420588] Key type ._llcrypt unregistered [14724.621105] Key type ._llcrypt registered [14724.622675] Key type .llcrypt registered [14725.536784] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 13:23:38 (1788456218) [14744.213210] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14744.238216] alg: No test for adler32 (adler32-zlib) [14745.499931] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14745.754957] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [14747.503297] Key type lgssc registered [14748.716666] Lustre: Echo OBD driver; http://www.lustre.org/ [14838.483035] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [14845.144299] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [14872.828392] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [14909.696791] Key type lgssc unregistered [14910.020880] LNet: 310380:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [14910.026678] LNetError: 310380:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [14910.042594] LNet: Removed LNI 192.168.206.23@tcp [14910.646653] Key type .llcrypt unregistered [14910.650198] Key type ._llcrypt unregistered [14927.953818] Key type ._llcrypt registered [14927.956680] Key type .llcrypt registered [14930.080553] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 13:27:01 (1788456421) [14933.262630] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [14933.295504] alg: No test for adler32 (adler32-zlib) [14934.651986] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [14935.000669] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [14936.848580] Key type lgssc registered [14937.787643] Lustre: Echo OBD driver; http://www.lustre.org/ [14999.272851] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15007.758469] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15030.649691] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15042.600541] Lustre: Mounted lustre-client - version 2.17.56_51_g2aa7cea [15106.209843] Lustre: Mounted fs15246-client - version 2.17.56_51_g2aa7cea [15122.258679] Lustre: Unmounted fs15246-client [15151.447352] Lustre: Unmounted lustre-client [15179.371992] Key type lgssc unregistered [15179.598823] LNet: 315257:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15179.624779] LNetError: 315257:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15179.655282] LNet: Removed LNI 192.168.206.23@tcp [15180.462856] Key type .llcrypt unregistered [15180.468909] Key type ._llcrypt unregistered [15193.205949] Key type ._llcrypt registered [15193.208223] Key type .llcrypt registered [15195.285714] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 13:31:27 (1788456687) [15197.910464] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [15198.090036] alg: No test for adler32 (adler32-zlib) [15199.267119] Lustre: Lustre: Build Version: 2.17.56_51_g2aa7cea [15199.586437] LNet: Added LNI 192.168.206.23@tcp [8/256/0/180] [15201.321218] Key type lgssc registered [15203.060150] Lustre: Echo OBD driver; http://www.lustre.org/ [15349.990788] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [15356.745154] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [15384.228127] Lustre: DEBUG MARKER: oleg623-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [15502.957118] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 15216 sec ========= 13:36:35 (1788456995) [15505.157659] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 13:36:37 (1788456997) === [15509.170366] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 13:36:41 (1788457001) === [15543.870463] Key type lgssc unregistered [15544.077775] LNet: 324535:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [15544.083064] LNetError: 324535:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [15544.102473] LNet: Removed LNI 192.168.206.23@tcp [15544.764706] Key type .llcrypt unregistered [15544.766786] Key type ._llcrypt unregistered