[ 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 452530824 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, 524588K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ftrace: allocating 41240 entries in 162 pages [ 0.000000] ftrace: allocated 162 pages with 3 groups [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x622/0x9a8 with crng_init=0 [ 0.001000] Console: colour *CGA 80x25 [ 0.001000] printk: console [ttyS1] enabled [ 0.001000] ACPI: Core revision 20220331 [ 0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.001013] APIC: Switch to symmetric I/O mode setup [ 0.003287] x2apic enabled [ 0.004010] Switched APIC routing to physical x2apic. [ 0.005015] kvm-guest: setup PV IPIs [ 0.007739] ..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.008027] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.009015] pid_max: default: 32768 minimum: 301 [ 0.010152] LSM: Security Framework initializing [ 0.011073] Yama: becoming mindful. [ 0.012038] SELinux: Initializing. [ 0.013075] *** VALIDATE selinux *** [ 0.021777] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) [ 0.026381] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) [ 0.027189] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.028131] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) [ 0.030138] *** VALIDATE tmpfs *** [ 0.031476] *** VALIDATE proc *** [ 0.033104] *** VALIDATE cgroup *** [ 0.034010] *** VALIDATE cgroup2 *** [ 0.035278] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.037131] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.038008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.039033] Spectre V2 : User space: Vulnerable [ 0.040010] Speculative Store Bypass: Vulnerable [ 0.043425] debug: unmapping init [mem 0xffffffffbb459000-0xffffffffbb460fff] [ 0.046000] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (family: 0x6, model: 0x3e, stepping: 0x4) [ 0.046734] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.047025] ... version: 2 [ 0.048016] ... bit width: 48 [ 0.049015] ... generic registers: 4 [ 0.050015] ... value mask: 0000ffffffffffff [ 0.051017] ... max period: 00007fffffffffff [ 0.052018] ... fixed-purpose events: 3 [ 0.053017] ... event mask: 000000070000000f [ 0.054344] rcu: Hierarchical SRCU implementation. [ 0.056573] smp: Bringing up secondary CPUs ... [ 0.057643] x86: Booting SMP configuration: [ 0.058029] .... node #0, CPUs: #1 #2 #3 [ 0.061517] smp: Brought up 1 node, 4 CPUs [ 0.063014] smpboot: Max logical packages: 1 [ 0.064020] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.148193] node 0 deferred pages initialised in 83ms [ 0.150257] devtmpfs: initialized [ 0.152281] x86/mm: Memory block size: 128MB [ 0.154838] gcov: version magic: 0x41383552 [ 0.158099] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.159092] futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) [ 0.160432] pinctrl core: initialized pinctrl subsystem [ 0.161205] [ 0.161783] ************************************************************* [ 0.162015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.163020] ** ** [ 0.164013] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 0.165014] ** ** [ 0.166012] ** This means that this kernel is built to expose internal ** [ 0.167017] ** IOMMU data structures, which may compromise security on ** [ 0.168014] ** your system. ** [ 0.169016] ** ** [ 0.170014] ** If you see this message and you are not debugging the ** [ 0.171014] ** kernel, report this immediately to your vendor! ** [ 0.172013] ** ** [ 0.173015] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.174014] ************************************************************* [ 0.175724] NET: Registered protocol family 16 [ 0.176457] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.177068] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.178062] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.180013] cpuidle: using governor menu [ 0.181676] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.183489] PCI: Using configuration type 1 for base access [ 0.185138] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.193060] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.195074] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.198216] cryptd: max_cpu_qlen set to 1000 [ 0.201282] ACPI: Added _OSI(Module Device) [ 0.203017] ACPI: Added _OSI(Processor Device) [ 0.204011] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.205014] ACPI: Added _OSI(Processor Aggregator Device) [ 0.210035] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.216066] ACPI: Interpreter enabled [ 0.217056] ACPI: PM: (supports S0 S3 S4 S5) [ 0.219018] ACPI: Using IOAPIC for interrupt routing [ 0.220101] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.223522] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.232000] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.235042] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.237032] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.240119] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.245331] acpiphp: Slot [2] registered [ 0.246110] acpiphp: Slot [5] registered [ 0.247135] acpiphp: Slot [6] registered [ 0.248108] acpiphp: Slot [3] registered [ 0.249082] acpiphp: Slot [4] registered [ 0.250090] acpiphp: Slot [7] registered [ 0.252096] acpiphp: Slot [8] registered [ 0.253094] acpiphp: Slot [9] registered [ 0.254095] acpiphp: Slot [10] registered [ 0.255125] acpiphp: Slot [11] registered [ 0.256095] acpiphp: Slot [12] registered [ 0.258089] acpiphp: Slot [13] registered [ 0.259088] acpiphp: Slot [14] registered [ 0.260098] acpiphp: Slot [15] registered [ 0.261098] acpiphp: Slot [16] registered [ 0.263119] acpiphp: Slot [17] registered [ 0.264085] acpiphp: Slot [18] registered [ 0.265095] acpiphp: Slot [19] registered [ 0.266089] acpiphp: Slot [20] registered [ 0.267129] acpiphp: Slot [21] registered [ 0.268097] acpiphp: Slot [22] registered [ 0.269117] acpiphp: Slot [23] registered [ 0.271102] acpiphp: Slot [24] registered [ 0.272078] acpiphp: Slot [25] registered [ 0.273113] acpiphp: Slot [26] registered [ 0.275110] acpiphp: Slot [27] registered [ 0.276100] acpiphp: Slot [28] registered [ 0.278119] acpiphp: Slot [29] registered [ 0.279128] acpiphp: Slot [30] registered [ 0.281108] acpiphp: Slot [31] registered [ 0.282088] PCI host bridge to bus 0000:00 [ 0.284023] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.286022] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.288028] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.289022] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.292023] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] [ 0.294033] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.296162] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.297835] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.301024] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.307016] pci 0000:00:01.1: reg 0x20: [io 0xc120-0xc12f] [ 0.311057] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.313020] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.315023] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.317017] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.320488] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.322727] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.325060] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.327798] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.330900] pci 0000:00:02.0: reg 0x10: [io 0xc100-0xc11f] [ 0.341016] pci 0000:00:02.0: reg 0x20: [mem 0xe0000000000-0xe0000003fff 64bit pref] [ 0.344017] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.349872] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.360016] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.369016] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.381013] pci 0000:00:05.0: reg 0x20: [mem 0xe0000004000-0xe0000007fff 64bit pref] [ 0.389014] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.402016] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.408016] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.426019] pci 0000:00:06.0: reg 0x20: [mem 0xe0000008000-0xe000000bfff 64bit pref] [ 0.436008] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.438333] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.440363] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.441363] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.443208] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.447045] iommu: Default domain type: Passthrough [ 0.448336] SCSI subsystem initialized [ 0.449148] ACPI: bus type USB registered [ 0.451115] usbcore: registered new interface driver usbfs [ 0.453082] usbcore: registered new interface driver hub [ 0.454114] usbcore: registered new device driver usb [ 0.456168] pps_core: LinuxPPS API ver. 1 registered [ 0.458012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.461105] PTP clock support registered [ 0.463129] EDAC MC: Ver: 3.0.0 [ 0.465087] PCI: Using ACPI for IRQ routing [ 0.466727] NetLabel: Initializing [ 0.468009] NetLabel: domain hash size = 128 [ 0.469010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.471100] NetLabel: unlabeled traffic allowed by default [ 0.472112] vgaarb: loaded [ 0.473239] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.475011] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.478363] clocksource: Switched to clocksource kvm-clock [ 0.584171] VFS: Disk quotas dquot_6.6.0 [ 0.585617] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.587973] *** VALIDATE ramfs *** [ 0.589147] *** VALIDATE hugetlbfs *** [ 0.590527] pnp: PnP ACPI init [ 0.592740] pnp: PnP ACPI: found 6 devices [ 0.623276] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.626075] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.627493] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.629209] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.631389] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 0.633637] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] [ 0.636297] NET: Registered protocol family 2 [ 0.638335] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) [ 0.641676] tcp_listen_portaddr_hash hash table entries: 4096 (order: 5, 163840 bytes, vmalloc) [ 0.645293] TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) [ 0.650551] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) [ 0.653674] TCP: Hash tables configured (established 65536 bind 65536) [ 0.655842] MPTCP token hash table entries: 8192 (order: 6, 393216 bytes, vmalloc) [ 0.658175] UDP hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.660174] UDP-Lite hash table entries: 4096 (order: 6, 393216 bytes, vmalloc) [ 0.662531] NET: Registered protocol family 1 [ 0.664279] RPC: Registered named UNIX socket transport module. [ 0.665668] RPC: Registered udp transport module. [ 0.666717] RPC: Registered tcp transport module. [ 0.668289] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.670121] NET: Registered protocol family 44 [ 0.671379] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.672783] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.674629] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.676494] PCI: CLS 0 bytes, default 64 [ 0.678760] Unpacking initramfs... [ 2.080213] debug: unmapping init [mem 0xffff88913cc64000-0xffff88913ffcffff] [ 2.083974] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.086023] software IO TLB: mapped [mem 0x00000000a8000000-0x00000000ac000000] (64MB) [ 2.088880] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229835b7123, max_idle_ns: 440795242976 ns [ 2.608960] Initialise system trusted keyrings [ 2.610208] Key type blacklist registered [ 2.611458] workingset: timestamp_bits=36 max_order=20 bucket_order=0 [ 2.619135] zbud: loaded [ 2.621755] *** VALIDATE nfs *** [ 2.622526] *** VALIDATE nfs4 *** [ 2.623490] pstore: using deflate compression [ 2.626061] Platform Keyring initialized [ 2.721743] NET: Registered protocol family 38 [ 2.723150] Key type asymmetric registered [ 2.724222] Asymmetric key parser 'x509' registered [ 2.725559] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [ 2.728049] io scheduler mq-deadline registered [ 2.729569] io scheduler kyber registered [ 2.731292] io scheduler bfq registered [ 2.732869] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 2.735354] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 2.737925] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.740691] ACPI: Power Button [PWRF] [ 2.746507] ACPI: \_SB_.LNKB: Enabled at IRQ 10 [ 2.753737] ACPI: \_SB_.LNKA: Enabled at IRQ 11 [ 2.763355] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.791473] 00:03: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 2.819578] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.824565] Non-volatile memory driver v1.3 [ 2.825903] Linux agpgart interface v0.103 [ 2.854898] virtio_blk virtio1: [vda] 146696 512-byte logical blocks (75.1 MB/71.6 MiB) [ 2.857655] vda: detected capacity change from 0 to 75108352 [ 2.872580] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 2.875541] vdb: detected capacity change from 0 to 1073741824 [ 2.886064] libphy: Fixed MDIO Bus: probed [ 2.893396] usbcore: registered new interface driver usbserial_generic [ 2.895877] usbserial: USB Serial support registered for generic [ 2.898218] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.902353] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.904037] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.906391] mousedev: PS/2 mouse device common for all mice [ 2.908738] rtc_cmos 00:05: RTC can wake from S4 [ 2.911173] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.911430] rtc_cmos 00:05: registered as rtc0 [ 2.915515] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 2.918342] intel_pstate: CPU model not supported [ 2.920866] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.922936] hid: raw HID events driver (C) Jiri Kosina [ 2.926584] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.929086] usbcore: registered new interface driver usbhid [ 2.930409] usbhid: USB HID core driver [ 2.931353] drop_monitor: Initializing network drop monitor service [ 2.933100] Initializing XFRM netlink socket [ 2.934426] NET: Registered protocol family 10 [ 2.937444] Segment Routing with IPv6 [ 2.938787] NET: Registered protocol family 17 [ 2.940740] mpls_gso: MPLS GSO support [ 2.945617] RAS: Correctable Errors collector initialized. [ 2.946811] AVX version of gcm_enc/dec engaged. [ 2.947812] AES CTR mode by8 optimization enabled [ 3.017766] sched_clock: Marking stable (3017744959, 0)->(3946452217, -928707258) [ 3.020773] registered taskstats version 1 [ 3.021902] Loading compiled-in X.509 certificates [ 3.023446] zswap: loaded using pool lzo/zbud [ 3.047747] Key type big_key registered [ 3.059197] Key type encrypted registered [ 3.060347] ima: No TPM chip found, activating TPM-bypass! [ 3.061396] ima: Allocated hash algorithm: sha1 [ 3.062231] ima: No architecture policies found [ 3.063268] evm: Initialising EVM extended attributes: [ 3.064266] evm: security.selinux [ 3.064874] evm: security.ima [ 3.065615] evm: security.capability [ 3.066404] evm: HMAC attrs: 0x1 [ 3.067825] rtc_cmos 00:05: setting system clock to 2026-09-13 10:50:43 UTC (1789296643) [ 3.071796] debug: unmapping init [mem 0xffffffffbc403000-0xffffffffbc5fffff] [ 3.073843] debug: unmapping init [mem 0xffffffffbb182000-0xffffffffbb458fff] [ 3.079083] Write protecting the kernel read-only data: 28672k [ 3.081116] debug: unmapping init [mem 0xffffffffb9803000-0xffffffffb99fffff] [ 3.082636] debug: unmapping init [mem 0xffffffffba114000-0xffffffffba1fffff] [ 3.109152] 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.114419] systemd[1]: Detected virtualization kvm. [ 3.115897] systemd[1]: Detected architecture x86-64. [ 3.117213] systemd[1]: Running in initial RAM disk. Welcome to Rocky Linux 8.10 (Green Obsidian) dracut-049-233.git20240115.el8 (Initramfs)! [ 3.143690] systemd[1]: No hostname configured. [ 3.145375] systemd[1]: Set hostname to . [ 3.147058] random: systemd: uninitialized urandom read (16 bytes read) [ 3.148534] systemd[1]: Initializing machine ID from random generator. [ 3.270542] random: systemd: uninitialized urandom read (16 bytes read) [ 3.272712] systemd[1]: Reached target Initrd Root Device. [ OK ] Reached target Initrd Root Device. [ 3.276472] random: systemd: uninitialized urandom read (16 bytes read) [ 3.278297] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 3.285271] systemd[1]: Starting Setup Virtual Console... Starting Setup Virtual Console... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Started Memstrack Anylazing Service. [ OK ] Reached target Timers. [ OK ] Listening on udev Kernel Socket. Starting Apply Kernel Variables... [ OK ] Reached target Slices. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Listening on Journal Socket (/dev/log). [ OK ] Reached target Swap. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Listening on udev Control Socket. [ OK ] Reached target Sockets. Starting Journal Service... [ OK ] Started Setup Virtual Console. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Started Apply Kernel Variables. [ OK ] Started Create Volatile Files and Directories. Starting Create Static Device Nodes in /dev... Starting dracut cmdline hook... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Started Journal Service. [ OK ] Started dracut cmdline hook. Starting dracut pre-udev hook... [ 3.826785] device-mapper: uevent: version 1.0.3 [ 3.828261] 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.415773] virtio_net virtio0 ens2: renamed from eth0 [ 4.456441] scsi host0: ata_piix [ 4.468291] scsi host1: ata_piix [ 4.481425] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc120 irq 14 [ 4.483866] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc128 irq 15 [ 8.278109] dracut-initqueue[580]: RTNETLINK answers: File exists [ 9.590631] random: crng init done [ 9.591902] random: 7 urandom warning(s) missed due to ratelimiting Starting nbd nbd0... [ OK ] Started nbd nbd0. [ OK ] Started dracut initqueue hook. Mounting /sysroot... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 9.951213] 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... Stopping Hardware RNG Entropy Gatherer Daemon... [ OK ] Stopped target Timers. [ OK ] Stopped dracut pre-pivot and cleanup hook. [ OK ] Stopped target Initrd Default Target. [ OK ] Stopped target Remote File Systems. [ OK ] Stopped target Remote File Systems (Pre). [ OK ] Stopped dracut initqueue hook. [ OK ] Stopped target Initrd Root Device. [ OK ] Stopped Hardware RNG Entropy Gatherer Daemon. [ OK ] Stopped target Basic System. [ OK ] Stopped target Sockets. [ OK ] Stopped target Paths. [ OK ] Stopped target Slices. [ OK ] Stopped target System Initialization. [ OK ] Stopped Create Volatile Files and Directories. [ OK ] Stopped udev Coldplug all Devices. [ OK ] Stopped dracut pre-trigger hook. Stopping udev Kernel Device Manager... [ OK ] Stopped target Local Encrypted Volumes. [ OK ] Stopped Dispatch Password Requests to Console Directory Watch. [ OK ] Stopped Apply Kernel Variables. [ OK ] Stopped target Local File Systems. [ OK ] Stopped target Swap. [ OK ] Stopped udev Kernel Device Manager. [ OK ] Started Cleaning Up and Shutting Down Daemons. [ OK ] Stopped dracut pre-udev hook. [ OK ] Stopped dracut cmdline hook. [ OK ] Stopped Create Static Device Nodes in /dev. [ OK ] Stopped Create list of required sta…vice nodes for the current kernel. [ OK ] Closed udev Kernel Socket. [ OK ] Closed udev Control Socket. Starting Cleanup udevd DB... [ OK ] Started Cleanup udevd DB. [ OK ] Reached target Switch Root. Starting Switch Root... [ 11.080365] printk: systemd: 26 output lines suppressed due to ratelimiting [ 11.326950] SELinux: Disabled at runtime. [ 11.384967] 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.391920] systemd[1]: Detected virtualization kvm. [ 11.393545] systemd[1]: Detected architecture x86-64. Welcome to Rocky Linux 8.10 (Green Obsidian)! [ 11.903634] systemd[1]: initrd-switch-root.service: Succeeded. [ 11.906434] systemd[1]: Stopped Switch Root. [ OK ] Stopped Switch Root. [ 11.909745] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart. [ 11.912471] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. [ 11.914874] systemd[1]: Stopped Journal Service. [ OK ] Stopped Journal Service. [ 11.923733] systemd[1]: Starting Journal Service... Starting Journal Service... [ 11.927769] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. Activating swap /dev/disk/by-label/SWAP... [ OK ] Listening on udev Kernel Socket. [ OK ] Created slice system-sshd\x2dkeygen.slice. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ 11.955349] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ OK ] Listening on Process Core Dump Socket. [ OK ] Listening on udev Control Socket. [FAILED] Failed to set up automount Arbitrar…rmats File System Automount Point. See 'systemctl status proc-sys-fs-binfmt_misc.automount' for details. Mounting Kernel Debug File System... [ OK ] Listening on initctl Compatibility Named Pipe. [ OK ] Listening on RPCbind Server Activation Socket. Starting udev Coldplug all Devices... Starting Create list of required st…ce nodes for the current kernel... [ OK ] Reached target RPC Port Mapper. [ OK ] Created slice system-getty.slice. [ OK ] Reached target rpc_pipefs.target. Mounting Huge Pages File System... [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Reached target Local Encrypted Volumes. [ OK ] Created slice User and Session Slice. Mounting POSIX Message Queue File System... [ OK ] Stopped target Switch Root. [ OK ] Stopped target Initrd File Systems. [ OK ] Stopped target Initrd Root File System. [ OK ] Reached target Slices. Starting Remount Root and Kernel File Systems... Starting Apply Kernel Variables... [ OK ] Reached target Paths. [ OK ] Started Journal Service. [ OK ] Activated swap /dev/disk/by-label/SWAP. [ OK ] Mounted Kernel Debug File System. [ OK ] Started Create list of required sta…vice nodes for the current kernel. [ OK ] Mounted Huge Pages File System. [ OK ] Mounted POSIX Message Queue File System. [FAILED] Failed to start Remount Root and Kernel File Systems. See 'systemctl status systemd-remount-fs.service' for details. [ OK ] Started Apply Kernel Variables. Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... [ OK ] Reached target Swap. Starting Flush Journal to Persistent Storage... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /home/green/git/lustre-release... Mounting /mnt... Starting udev Kernel Device Manager... [ 12.367057] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ OK ] Started udev Coldplug all Devices. [ OK ] Mounted /home/green/git/lustre-release. [ OK ] Mounted /mnt. [ OK ] Started udev Kernel Device Manager. [ 12.731659] input: PC Speaker as /devices/platform/pcspkr/input/input5 [ 12.793497] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 12.928947] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer [ 12.948951] EDAC sbridge: Ver: 1.1.2 [ 14.018239] Key type dns_resolver registered [ 14.344248] NFS: Registering the id_resolver key type [ 14.345966] Key type id_resolver registered [ 14.347326] 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 Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... Starting Create Volatile Files and Directories... [ OK ] Started Mark the need to relabel after reboot. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting RPC Bind... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC Bind. [ OK ] Started Rebuild Dynamic Linker Cache. Starting Update is Completed... [ OK ] Started Update is Completed. [ OK ] Reached target System Initialization. [ OK ] Started daily update of the root trust anchor for DNSSEC. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Reached target Sockets. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Basic System. [ OK ] Started D-Bus System Message Bus. Starting Network Manager... Starting Restore /run/initramfs on shutdown... Starting Login Service... [ OK ] Started irqbalance daemon. [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Reached target sshd-keygen.target. [ OK ] Started dnf makecache --timer. [ OK ] Reached target Timers. [ OK ] Started Restore /run/initramfs on shutdown. [ OK ] Started Login Service. [ OK ] Started Network Manager. [ OK ] Reached target Network. Starting GSSAPI Proxy Daemon... Starting Dynamic System Tuning Daemon... Starting OpenSSH server daemon... Starting Network Manager Wait Online... [ 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... Starting Hostname Service... [ 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 Crash recovery kernel arming... Starting System Logging Service... Starting Notify NFS peers of a restart... [ OK ] Started Notify NFS peers of a restart. [ OK ] Started System Logging Service. 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 oleg238-client login: [ 29.970909] hrtimer: interrupt took 4861775 ns [ 75.486469] libcfs: loading out-of-tree module taints kernel. [ 75.742416] Key type ._llcrypt registered [ 75.747132] Key type .llcrypt registered [ 76.463780] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 76.485669] alg: No test for adler32 (adler32-zlib) [ 78.000748] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 79.215565] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 81.055159] Key type lgssc registered [ 82.983825] Lustre: Echo OBD driver; http://www.lustre.org/ [ 259.689917] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 264.715614] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 276.218875] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing check_logdir /tmp/testlogs/ [ 282.464601] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing yml_node [ 285.152125] Lustre: lustre-OST0000-osc-ffff8891897d1000: disconnect after 23s idle [ 286.794236] Lustre: DEBUG MARKER: Client: 2.17.57.108 [ 289.314136] Lustre: DEBUG MARKER: MDS: 2.17.57.108 [ 291.794682] Lustre: DEBUG MARKER: OSS: 2.17.57.108 [ 293.070085] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Sun Sep 13 06:55:32 EDT 2026 [ 313.224052] Lustre: DEBUG MARKER: excepting tests: 55 63 67 32newtarball [ 315.380401] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 318.027459] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 328.372637] Lustre: Unmounted lustre-client [ 450.335186] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 456.678048] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 482.139984] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 522.631792] Lustre: DEBUG MARKER: == conf-sanity test 33a: Mount ost with a large index number ========================================================== 06:59:21 (1789297161) [ 525.142889] Lustre: DEBUG MARKER: SKIP: conf-sanity test_33a mixed loopback and real device not working [ 526.658283] Lustre: DEBUG MARKER: == conf-sanity test 33b: Drop cancel during umount ======= 06:59:25 (1789297165) [ 565.383616] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 572.243240] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 594.462835] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 595.268524] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 603.624661] Lustre: Unmounted lustre-client [ 634.100755] Key type lgssc unregistered [ 634.447333] LNet: 15031:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 634.474020] LNetError: 15031:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 634.512183] LNet: Removed LNI 192.168.202.38@tcp [ 635.619165] Key type .llcrypt unregistered [ 635.621186] Key type ._llcrypt unregistered [ 652.311305] Key type ._llcrypt registered [ 652.313346] Key type .llcrypt registered [ 653.685602] Lustre: DEBUG MARKER: == conf-sanity test 33c: Mount ost with a large index number ========================================================== 07:01:32 (1789297292) [ 655.432470] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 655.518769] alg: No test for adler32 (adler32-zlib) [ 656.625578] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 656.869828] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 658.567187] Key type lgssc registered [ 659.676865] Lustre: Echo OBD driver; http://www.lustre.org/ [ 733.079907] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 824.557044] Lustre: Unmounted lustre-client [ 854.109744] Key type lgssc unregistered [ 854.333821] LNet: 18806:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 854.341398] LNetError: 18806:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 854.356442] LNet: Removed LNI 192.168.202.38@tcp [ 855.287358] Key type .llcrypt unregistered [ 855.289647] Key type ._llcrypt unregistered [ 866.637743] Key type ._llcrypt registered [ 866.641615] Key type .llcrypt registered [ 868.713835] Lustre: DEBUG MARKER: == conf-sanity test 33d: Don't panic when enable project quota ========================================================== 07:05:06 (1789297506) [ 871.999186] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 872.067209] alg: No test for adler32 (adler32-zlib) [ 873.255845] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 873.504586] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 875.271605] Key type lgssc registered [ 876.876417] Lustre: Echo OBD driver; http://www.lustre.org/ [ 931.277898] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 936.878154] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 958.384822] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 960.619479] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 976.310041] Lustre: Unmounted lustre-client [ 1000.468746] Key type lgssc unregistered [ 1000.792783] LNet: 22404:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1000.809741] LNetError: 22404:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1000.839361] LNet: Removed LNI 192.168.202.38@tcp [ 1001.738586] Key type .llcrypt unregistered [ 1001.740585] Key type ._llcrypt unregistered [ 1013.832057] Key type ._llcrypt registered [ 1013.834794] Key type .llcrypt registered [ 1015.022511] Lustre: DEBUG MARKER: == conf-sanity test 34a: umount with opened file should be fail ========================================================== 07:07:34 (1789297654) [ 1017.940167] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1017.987835] alg: No test for adler32 (adler32-zlib) [ 1019.042398] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 1019.267437] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 1020.903503] Key type lgssc registered [ 1022.085888] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1077.231919] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1083.813782] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1107.961912] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1110.885978] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 1117.614027] Lustre: Unmounted lustre-client [ 1154.046597] Key type lgssc unregistered [ 1154.345533] LNet: 25589:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1154.352390] LNetError: 25589:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1154.377922] LNet: Removed LNI 192.168.202.38@tcp [ 1155.197244] Key type .llcrypt unregistered [ 1155.199974] Key type ._llcrypt unregistered [ 1171.843328] Key type ._llcrypt registered [ 1171.845490] Key type .llcrypt registered [ 1173.815442] Lustre: DEBUG MARKER: == conf-sanity test 34b: force umount with failed mds should be normal ========================================================== 07:10:12 (1789297812) [ 1176.475798] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1176.715330] alg: No test for adler32 (adler32-zlib) [ 1177.922025] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 1178.325118] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 1180.047256] Key type lgssc registered [ 1181.333636] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1237.558108] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1244.059464] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1266.402330] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1269.373485] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 1274.344188] Lustre: lustre-MDT0000-mdc-ffff8891892c5000: Connection to lustre-MDT0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1284.582158] Lustre: lustre-MDT0001-mdc-ffff8891892c5000: Connection to lustre-MDT0001 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1288.931405] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1294.751567] Lustre: 26546:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789297919/real 1789297919] req@00000000193620e8 x1876214748812800/t0(0) o400->MGC192.168.202.138@tcp@192.168.202.138@tcp:26/25 lens 224/224 e 0 to 1 dl 1789297935 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 1294.776393] LustreError: MGC192.168.202.138@tcp: Connection to MGS (at 192.168.202.138@tcp) was lost; in progress operations using this service will fail [ 1299.291348] Lustre: Unmounted lustre-client [ 1318.788304] Key type lgssc unregistered [ 1319.079628] LNet: 29244:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1319.087786] LNetError: 29244:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1320.101826] LNet: Removed LNI 192.168.202.38@tcp [ 1320.915244] Key type .llcrypt unregistered [ 1320.916800] Key type ._llcrypt unregistered [ 1338.024698] Key type ._llcrypt registered [ 1338.036128] Key type .llcrypt registered [ 1339.369112] Lustre: DEBUG MARKER: == conf-sanity test 34c: force umount with failed ost should be normal ========================================================== 07:12:58 (1789297978) [ 1341.963676] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1342.032640] alg: No test for adler32 (adler32-zlib) [ 1343.168608] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 1343.508690] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 1345.303461] Key type lgssc registered [ 1346.710600] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1397.706394] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1403.691135] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1426.819471] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1429.494301] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 1439.745237] Lustre: lustre-OST0000-osc-ffff889198d73800: Connection to lustre-OST0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1445.286483] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 1455.585986] Lustre: Unmounted lustre-client [ 1482.370319] Key type lgssc unregistered [ 1482.656976] LNet: 32851:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1482.668249] LNetError: 32851:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1482.686785] LNet: Removed LNI 192.168.202.38@tcp [ 1483.492772] Key type .llcrypt unregistered [ 1483.494708] Key type ._llcrypt unregistered [ 1498.667861] Key type ._llcrypt registered [ 1498.669473] Key type .llcrypt registered [ 1499.967755] Lustre: DEBUG MARKER: == conf-sanity test 35a: Reconnect to the last active server first ========================================================== 07:15:38 (1789298138) [ 1502.380352] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1502.429803] alg: No test for adler32 (adler32-zlib) [ 1503.481839] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 1503.775987] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 1505.479226] Key type lgssc registered [ 1506.810480] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1561.330747] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1568.104727] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1589.410899] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1592.040306] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 1599.169429] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1602.543185] Lustre: DEBUG MARKER: Wait for RECONNECT_INTERVAL seconds (10s) [ 1614.387378] Lustre: DEBUG MARKER: conf-sanity.sh test_35a 2026-09-13 7h17m33s [ 1616.554441] Lustre: DEBUG MARKER: Stopping the MDT: lustre-MDT0000 [ 1623.017083] Lustre: lustre-MDT0000-mdc-ffff889190b39000: Connection to lustre-MDT0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1627.088334] LustreError: 36633:0:(lmv_obd.c:1471:lmv_statfs()) lustre-MDT0000-mdc-ffff889190b39000: can't stat MDS #0: rc = -19 [ 1628.680267] Lustre: DEBUG MARKER: Restarting the MDT: lustre-MDT0000 [ 1641.471021] LustreError: MGC192.168.202.138@tcp: Connection to MGS (at 192.168.202.138@tcp) was lost; in progress operations using this service will fail [ 1641.499729] Lustre: Evicted from MGS (at 192.168.202.138@tcp) after server handle changed from 0xb5a09c542ff5a3c7 to 0xb5a09c542ff5a691 [ 1641.519407] Lustre: MGC192.168.202.138@tcp: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 1642.543932] LustreError: lustre-MDT0000-mdc-ffff889190b39000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 1642.558668] Lustre: lustre-MDT0000-mdc-ffff889190b39000: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 1645.959866] Lustre: DEBUG MARKER: Wait for df (36633) ... [ 1647.513466] Lustre: DEBUG MARKER: done [ 1648.952481] Lustre: Unmounted lustre-client [ 1685.482506] Key type lgssc unregistered [ 1685.809193] LNet: 37650:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1685.823826] LNetError: 37650:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1685.842632] LNet: Removed LNI 192.168.202.38@tcp [ 1686.691198] Key type .llcrypt unregistered [ 1686.697092] Key type ._llcrypt unregistered [ 1723.365738] Key type ._llcrypt registered [ 1723.367584] Key type .llcrypt registered [ 1724.736543] Lustre: DEBUG MARKER: == conf-sanity test 35b: Continue reconnection retries, if the active server is busy ========================================================== 07:19:23 (1789298363) [ 1727.465955] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1727.506901] alg: No test for adler32 (adler32-zlib) [ 1728.566529] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 1728.866630] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 1730.631186] Key type lgssc registered [ 1732.150732] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1793.985896] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 1800.439244] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 1822.213585] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 1824.120796] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 1828.557545] Lustre: DEBUG MARKER: conf-sanity.sh test_35b 2026-09-13 7h21m07s [ 1830.076251] Lustre: DEBUG MARKER: Set up a fake failnode for the MDS [ 1838.681044] Lustre: DEBUG MARKER: Injecting EBUSY on MDS [ 1841.650797] Lustre: DEBUG MARKER: Creating a test file and stat it [ 1862.111295] Lustre: 41793:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789298482/real 1789298482] req@00000000abd472aa x1876215326579200/t0(0) o101->lustre-MDT0000-mdc-ffff8891988ab800@192.168.202.138@tcp:12/10 lens 576/1152 e 0 to 1 dl 1789298502 ref 2 fl Rpc:XQr/600/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:1 [ 1862.152626] Lustre: lustre-MDT0000-mdc-ffff8891988ab800: Connection to lustre-MDT0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 1862.203429] Lustre: lustre-MDT0000-mdc-ffff8891988ab800: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 1883.913180] Lustre: DEBUG MARKER: Stop injecting EBUSY on MDS [ 1887.092978] Lustre: DEBUG MARKER: done [ 1891.575955] Lustre: Unmounted lustre-client [ 1919.805216] Key type lgssc unregistered [ 1920.159996] LNet: 42678:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1920.167847] LNetError: 42678:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 1920.225366] LNet: Removed LNI 192.168.202.38@tcp [ 1921.076294] Key type .llcrypt unregistered [ 1921.078507] Key type ._llcrypt unregistered [ 1954.829130] Key type ._llcrypt registered [ 1954.831431] Key type .llcrypt registered [ 1956.163499] Lustre: DEBUG MARKER: == conf-sanity test 36: df report consistency on OSTs with different block size ========================================================== 07:23:15 (1789298595) [ 1957.862497] Lustre: DEBUG MARKER: SKIP: conf-sanity test_36 remote OST [ 1959.386455] Lustre: DEBUG MARKER: == conf-sanity test 37: verify set tunables works for symlink device ========================================================== 07:23:18 (1789298598) [ 1963.424768] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1963.475859] alg: No test for adler32 (adler32-zlib) [ 1964.658557] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 1965.021098] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 1966.767187] Key type lgssc registered [ 1968.179264] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1997.543272] Lustre: DEBUG MARKER: == conf-sanity test 38: MDS recreates missing lov_objid file from OST data ========================================================== 07:23:56 (1789298636) [ 2033.023328] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2039.511538] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2058.283722] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2059.850218] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 2063.235139] Lustre: DEBUG MARKER: copying 10 files to /mnt/lustre/d38.conf-sanity [ 2066.353738] Lustre: Unmounted lustre-client [ 2076.897404] Lustre: DEBUG MARKER: delete lov_objid file on MDS [ 2122.460583] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2127.153203] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2127.761634] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 2130.618853] Lustre: Unmounted lustre-client [ 2189.544981] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2194.246740] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2194.731240] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 2198.465711] Lustre: Unmounted lustre-client [ 2212.860668] Lustre: DEBUG MARKER: files compared the same [ 2236.003469] Key type lgssc unregistered [ 2236.209856] LNet: 50288:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2236.215449] LNetError: 50288:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2236.234350] LNet: Removed LNI 192.168.202.38@tcp [ 2236.649540] Key type .llcrypt unregistered [ 2236.651626] Key type ._llcrypt unregistered [ 2251.907942] Key type ._llcrypt registered [ 2251.910469] Key type .llcrypt registered [ 2253.459759] Lustre: DEBUG MARKER: == conf-sanity test 39: leak_finder recognizes both LUSTRE and LNET malloc messages ========================================================== 07:28:12 (1789298892) [ 2255.378436] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2255.402117] alg: No test for adler32 (adler32-zlib) [ 2256.434606] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 2256.660222] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 2258.322357] Key type lgssc registered [ 2259.671828] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2316.787983] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2322.885392] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2343.597498] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2346.363788] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 2353.981757] Lustre: Unmounted lustre-client [ 2381.465399] Key type lgssc unregistered [ 2381.709609] LNet: 53868:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2381.721233] LNetError: 53868:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2381.756324] LNet: Removed LNI 192.168.202.38@tcp [ 2382.474907] Key type .llcrypt unregistered [ 2382.482441] Key type ._llcrypt unregistered [ 2399.351687] Key type ._llcrypt registered [ 2399.353179] Key type .llcrypt registered [ 2400.830642] Lustre: DEBUG MARKER: == conf-sanity test 40: race during service thread startup ========================================================== 07:30:39 (1789299039) [ 2404.090230] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2404.160470] alg: No test for adler32 (adler32-zlib) [ 2405.405364] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 2405.840452] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 2407.551651] Key type lgssc registered [ 2409.223026] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2496.241626] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2528.919144] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 2535.853698] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 2573.582437] Key type lgssc unregistered [ 2573.963147] LNet: 57355:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2573.967293] LNetError: 57355:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2573.979592] LNet: Removed LNI 192.168.202.38@tcp [ 2574.819184] Key type .llcrypt unregistered [ 2574.823305] Key type ._llcrypt unregistered [ 2590.234233] Key type ._llcrypt registered [ 2590.237963] Key type .llcrypt registered [ 2591.705540] Lustre: DEBUG MARKER: == conf-sanity test 41a: mount mds with --nosvc and --nomgs ========================================================== 07:33:50 (1789299230) [ 2596.010313] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 2596.032355] alg: No test for adler32 (adler32-zlib) [ 2597.288611] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 2597.567736] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 2599.271534] Key type lgssc registered [ 2600.692822] Lustre: Echo OBD driver; http://www.lustre.org/ [ 2682.787747] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 2691.246412] Lustre: Unmounted lustre-client [ 2731.867761] Lustre: DEBUG MARKER: == conf-sanity test 41b: mount mds with --nosvc and --nomgs on first mount ========================================================== 07:36:10 (1789299370) [ 2858.642158] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 2880.095757] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 2887.288347] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 2887.295985] LustreError: 63834:0:(file.c:251:ll_close_inode_openhandle()) lustre-clilmv-ffff889190b3d000: inode [0x200000402:0x1:0x0] mdc close failed: rc = -108 [ 2887.312964] Lustre: 58340:0:(llite_lib.c:4342:ll_dirty_page_discard_warn()) lustre: dirty page discard: 192.168.202.138@tcp:/lustre/fid: [0x200000402:0x1:0x0]/ may get corrupted (rc -108) [ 2897.660320] Lustre: Unmounted lustre-client [ 2942.506637] Lustre: DEBUG MARKER: == conf-sanity test 41c: concurrent mounts of MDT/OST should all fail but one ========================================================== 07:39:41 (1789299581) [ 2954.793579] Key type lgssc unregistered [ 2955.099591] LNet: 65046:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 2955.112083] LNetError: 65046:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 2955.148187] LNet: Removed LNI 192.168.202.38@tcp [ 2955.912344] Key type .llcrypt unregistered [ 2955.913535] Key type ._llcrypt unregistered [ 2971.105525] Key type ._llcrypt registered [ 2971.115552] Key type .llcrypt registered [ 2972.150222] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 2972.164311] alg: No test for adler32 (adler32-zlib) [ 2973.340487] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 2973.764716] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 2975.615289] Key type lgssc registered [ 2977.277577] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3033.732339] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3039.399449] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3063.465937] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3065.333677] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 3072.483540] Lustre: Unmounted lustre-client [ 3105.743513] Key type lgssc unregistered [ 3106.248943] LNet: 68064:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3106.258174] LNetError: 68064:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3106.284415] LNet: Removed LNI 192.168.202.38@tcp [ 3106.825549] Key type .llcrypt unregistered [ 3106.826818] Key type ._llcrypt unregistered [ 3118.661374] Key type ._llcrypt registered [ 3118.665743] Key type .llcrypt registered [ 3119.249893] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3119.267726] alg: No test for adler32 (adler32-zlib) [ 3120.415747] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 3120.706129] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 3122.409054] Key type lgssc registered [ 3123.760246] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3239.448943] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3248.038180] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3268.665524] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3271.490810] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 3274.424827] Lustre: Unmounted lustre-client [ 3310.732798] Key type lgssc unregistered [ 3311.036672] LNet: 71491:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3311.043458] LNetError: 71491:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3311.055542] LNet: Removed LNI 192.168.202.38@tcp [ 3311.929804] Key type .llcrypt unregistered [ 3311.931988] Key type ._llcrypt unregistered [ 3330.406498] Key type ._llcrypt registered [ 3330.408156] Key type .llcrypt registered [ 3331.432660] Lustre: DEBUG MARKER: == conf-sanity test 42: allow client/server mount/unmount with invalid config param ========================================================== 07:46:10 (1789299970) [ 3333.748759] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3333.784058] alg: No test for adler32 (adler32-zlib) [ 3334.870144] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 3335.289903] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 3337.051098] Key type lgssc registered [ 3338.502542] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3392.566157] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3399.080918] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3421.874887] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3424.798924] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 3429.894149] Lustre: Unmounted lustre-client [ 3430.481898] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 3433.668217] Lustre: Unmounted lustre-client [ 3463.014746] Key type lgssc unregistered [ 3463.404845] LNet: 75187:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3463.411941] LNetError: 75187:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3463.441885] LNet: Removed LNI 192.168.202.38@tcp [ 3464.226407] Key type .llcrypt unregistered [ 3464.228557] Key type ._llcrypt unregistered [ 3476.736427] Key type ._llcrypt registered [ 3476.739873] Key type .llcrypt registered [ 3476.974840] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 3476.985420] alg: No test for adler32 (adler32-zlib) [ 3477.955971] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 3478.269662] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 3479.975356] Key type lgssc registered [ 3481.393509] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3531.324973] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3536.156392] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3556.860492] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3558.610400] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 3562.716596] Lustre: Unmounted lustre-client [ 3591.327891] Key type lgssc unregistered [ 3591.650792] LNet: 78214:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3591.666744] LNetError: 78214:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3591.693780] LNet: Removed LNI 192.168.202.38@tcp [ 3592.322249] Key type .llcrypt unregistered [ 3592.323877] Key type ._llcrypt unregistered [ 3606.991593] Key type ._llcrypt registered [ 3606.995321] Key type .llcrypt registered [ 3608.250803] Lustre: DEBUG MARKER: == conf-sanity test 43a: check root_squash and nosquash_nids ========================================================== 07:50:47 (1789300247) [ 3610.454402] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3610.488475] alg: No test for adler32 (adler32-zlib) [ 3611.718473] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 3611.929833] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 3613.583188] Key type lgssc registered [ 3614.415753] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3667.529605] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3673.454056] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3698.609323] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3700.158388] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 3705.965422] Lustre: lustre: root_squash is set to 0:0 [ 3713.608912] Lustre: lustre: nosquash_nids is cleared [ 3722.297569] Lustre: lustre: root_squash is set to 500:500 [ 3728.680682] Lustre: lustre: nosquash_nids set to 2@gni 0@lo 192.168.202.38@tcp 192.168.0.[2,10]@tcp [ 3738.021206] Lustre: lustre: nosquash_nids set to 192.168.202.38/24@tcp [ 3747.511171] Lustre: Unmounted lustre-client [ 3778.989768] Key type lgssc unregistered [ 3779.210922] LNet: 82196:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3779.218480] LNetError: 82196:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3779.240642] LNet: Removed LNI 192.168.202.38@tcp [ 3779.830953] Key type .llcrypt unregistered [ 3779.832875] Key type ._llcrypt unregistered [ 3797.684685] Key type ._llcrypt registered [ 3797.687689] Key type .llcrypt registered [ 3799.350961] Lustre: DEBUG MARKER: == conf-sanity test 43b: parse nosquash_nids with commas in expr_list ========================================================== 07:53:57 (1789300437) [ 3801.884881] Lustre: DEBUG MARKER: SKIP: conf-sanity test_43b mixed loopback and real device not working [ 3803.726697] Lustre: DEBUG MARKER: == conf-sanity test 44: mounted client proc entry exists ========================================================== 07:54:02 (1789300442) [ 3806.601353] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3806.623887] alg: No test for adler32 (adler32-zlib) [ 3807.632227] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 3807.844539] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 3809.513103] Key type lgssc registered [ 3810.529631] Lustre: Echo OBD driver; http://www.lustre.org/ [ 3863.838990] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 3870.537579] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 3892.800306] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 3894.530125] Lustre: lustre: root_squash is set to 500:500 [ 3894.580240] Lustre: lustre: nosquash_nids set to 192.168.202.38/24@tcp [ 3895.750488] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 3904.625314] Lustre: Unmounted lustre-client [ 3931.485550] Key type lgssc unregistered [ 3931.732359] LNet: 86148:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 3931.738315] LNetError: 86148:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 3931.755306] LNet: Removed LNI 192.168.202.38@tcp [ 3932.504547] Key type .llcrypt unregistered [ 3932.507226] Key type ._llcrypt unregistered [ 3945.779741] Key type ._llcrypt registered [ 3945.782322] Key type .llcrypt registered [ 3946.999048] Lustre: DEBUG MARKER: SKIP: conf-sanity test_45 skipping SLOW test 45 [ 3948.554156] Lustre: DEBUG MARKER: == conf-sanity test 46a: handle ost additional - wide striped file ========================================================== 07:56:27 (1789300587) [ 3965.831962] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 3965.842692] alg: No test for adler32 (adler32-zlib) [ 3967.116809] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 3967.440065] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 3969.111360] Key type lgssc registered [ 3970.883934] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4055.213292] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4061.222419] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4084.346535] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4153.789967] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4160.033712] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4181.479275] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4194.235067] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 4227.340267] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff889185029000.ost_server_uuid 50 [ 4229.151031] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff889185029000.ost_server_uuid in FULL state after 0 sec [ 4229.750279] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 4233.370226] Lustre: Unmounted lustre-client [ 4235.606932] Lustre: Unmounted lustre-client [ 4294.230499] Key type lgssc unregistered [ 4294.445366] LNet: 93821:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4294.449453] LNetError: 93821:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4294.467510] LNet: Removed LNI 192.168.202.38@tcp [ 4295.127344] Key type .llcrypt unregistered [ 4295.129264] Key type ._llcrypt unregistered [ 4326.955338] Key type ._llcrypt registered [ 4326.957633] Key type .llcrypt registered [ 4328.680799] Lustre: DEBUG MARKER: == conf-sanity test 47a: server restart does not lose lru_resize ========================================================== 08:02:47 (1789300967) [ 4346.862568] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4347.045130] alg: No test for adler32 (adler32-zlib) [ 4348.088739] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 4348.430597] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 4350.071351] Key type lgssc registered [ 4351.901336] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4445.865781] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4452.543355] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4479.327037] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4482.132681] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 4503.519553] Lustre: 95179:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789301127/real 1789301127] req@00000000133f8a2c x1876218072798464/t0(0) o400->lustre-OST0000-osc-ffff889191a8e000@192.168.202.138@tcp:28/4 lens 224/224 e 0 to 1 dl 1789301143 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4503.606467] Lustre: lustre-OST0000-osc-ffff889191a8e000: Connection to lustre-OST0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4508.203656] Lustre: 95180:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789301132/real 1789301132] req@0000000094b50c5d x1876218072798976/t0(0) o400->lustre-OST0000-osc-ffff889191a8e000@192.168.202.138@tcp:28/4 lens 224/224 e 0 to 1 dl 1789301148 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4512.738183] Lustre: 95179:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789301137/real 1789301137] req@000000004a24d7d7 x1876218072799488/t0(0) o400->lustre-OST0000-osc-ffff889191a8e000@192.168.202.138@tcp:28/4 lens 224/224 e 0 to 1 dl 1789301153 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4514.263284] Lustre: lustre-OST0000-osc-ffff889191a8e000: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 4517.855188] Lustre: 95180:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789301142/real 1789301142] req@000000000372e75a x1876218072800000/t0(0) o400->lustre-OST0000-osc-ffff889191a8e000@192.168.202.138@tcp:28/4 lens 224/224 e 0 to 1 dl 1789301158 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4518.893372] Lustre: lustre-MDT0000-mdc-ffff889191a8e000: Connection to lustre-MDT0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 4535.263222] Lustre: 95180:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789301159/real 1789301159] req@000000007448a8cf x1876218072802176/t0(0) o400->MGC192.168.202.138@tcp@192.168.202.138@tcp:26/25 lens 224/224 e 0 to 1 dl 1789301175 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 4535.287729] LustreError: MGC192.168.202.138@tcp: Connection to MGS (at 192.168.202.138@tcp) was lost; in progress operations using this service will fail [ 4545.523186] Lustre: Evicted from MGS (at 192.168.202.138@tcp) after server handle changed from 0x65c5cc95714d1920 to 0x65c5cc95714d1bf1 [ 4545.534561] Lustre: MGC192.168.202.138@tcp: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 4547.695234] Lustre: lustre-MDT0000-mdc-ffff889191a8e000: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 4551.950916] Lustre: Unmounted lustre-client [ 4579.547957] Key type lgssc unregistered [ 4579.845169] LNet: 99478:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 4579.858283] LNetError: 99478:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 4580.904705] LNet: Removed LNI 192.168.202.38@tcp [ 4581.635340] Key type .llcrypt unregistered [ 4581.641968] Key type ._llcrypt unregistered [ 4598.482343] Key type ._llcrypt registered [ 4598.484949] Key type .llcrypt registered [ 4600.008893] Lustre: DEBUG MARKER: == conf-sanity test 47b: client restart does not lose lru_resize ========================================================== 08:07:18 (1789301238) [ 4615.181723] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 4615.219236] alg: No test for adler32 (adler32-zlib) [ 4616.299379] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 4616.556205] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 4618.215230] Key type lgssc registered [ 4619.592670] Lustre: Echo OBD driver; http://www.lustre.org/ [ 4660.201579] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4760.901267] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 4766.846502] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 4791.161578] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 4793.883814] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 4795.777397] Lustre: DEBUG MARKER: SKIP: conf-sanity test_47b Can not create symlink /usr/sbin/lctl [ 4797.253746] Lustre: DEBUG MARKER: == conf-sanity test 48: too many acls on file ============ 08:10:36 (1789301436) [ 5009.595806] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 5019.968928] Lustre: Unmounted lustre-client [ 5144.566546] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5151.293963] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5179.366271] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5227.550685] Lustre: DEBUG MARKER: == conf-sanity test 49a: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 08:17:46 (1789301866) [ 5318.877664] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5323.601131] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5350.811316] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5351.507896] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 5356.564264] Lustre: Unmounted lustre-client [ 5387.864535] Lustre: DEBUG MARKER: == conf-sanity test 49b: check PARAM_SYS_LDLM_TIMEOUT option of mkfs.lustre ========================================================== 08:20:26 (1789302026) [ 5482.602559] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5489.166320] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5513.736659] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5514.511239] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 5519.459725] Lustre: Unmounted lustre-client [ 5547.613082] Key type lgssc unregistered [ 5547.968360] LNet: 122482:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5547.987171] LNetError: 122482:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5548.006793] LNet: Removed LNI 192.168.202.38@tcp [ 5548.820229] Key type .llcrypt unregistered [ 5548.835298] Key type ._llcrypt unregistered [ 5566.233395] Key type ._llcrypt registered [ 5566.243362] Key type .llcrypt registered [ 5567.813354] Lustre: DEBUG MARKER: == conf-sanity test 50a: lazystatfs all servers available ========================================================== 08:23:26 (1789302206) [ 5570.215916] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5570.284232] alg: No test for adler32 (adler32-zlib) [ 5571.408758] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 5571.768055] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 5573.519879] Key type lgssc registered [ 5574.651347] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5627.250984] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5633.815672] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5654.840655] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5657.461600] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 5674.327777] Lustre: Unmounted lustre-client [ 5705.035481] Key type lgssc unregistered [ 5705.454962] LNet: 126072:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 5705.459813] LNetError: 126072:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 5705.483032] LNet: Removed LNI 192.168.202.38@tcp [ 5706.181803] Key type .llcrypt unregistered [ 5706.183260] Key type ._llcrypt unregistered [ 5722.078880] Key type ._llcrypt registered [ 5722.081244] Key type .llcrypt registered [ 5723.499190] Lustre: DEBUG MARKER: == conf-sanity test 50b: lazystatfs all servers down ===== 08:26:02 (1789302362) [ 5725.779370] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 5725.825226] alg: No test for adler32 (adler32-zlib) [ 5726.860725] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 5727.157220] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 5728.911238] Key type lgssc registered [ 5730.276309] Lustre: Echo OBD driver; http://www.lustre.org/ [ 5775.659861] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5780.676054] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5801.056526] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5802.728611] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 5808.107973] Lustre: lustre-OST0000-osc-ffff889187aba800: Connection to lustre-OST0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5819.891792] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state DISCONN osc.lustre-OST0000-osc-ffff889187aba800.ost_server_uuid 50 [ 5821.215746] Lustre: DEBUG MARKER: OSCs should all be DISCONN [ 5832.325421] Lustre: Unmounted lustre-client [ 5853.659912] Lustre: DEBUG MARKER: == conf-sanity test 50c: lazystatfs one server down ====== 08:28:12 (1789302492) [ 5884.482339] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 5889.925853] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 5908.391753] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5935.269751] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 5935.963851] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 5941.227993] Lustre: lustre-OST0000-osc-ffff889191a8b800: Connection to lustre-OST0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 5968.291773] Lustre: Unmounted lustre-client [ 6013.508694] Lustre: DEBUG MARKER: == conf-sanity test 50d: lazystatfs client/server conn race ========================================================== 08:30:52 (1789302652) [ 6047.482579] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6053.631555] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6077.192780] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6101.069434] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6101.545731] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 6106.603137] Lustre: lustre-OST0000-osc-ffff889187997800: Connection to lustre-OST0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6122.597574] Lustre: Unmounted lustre-client [ 6173.952446] Lustre: DEBUG MARKER: == conf-sanity test 50e: normal statfs all servers down == 08:33:32 (1789302812) [ 6265.403403] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6270.713524] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6295.378813] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6369.317900] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6374.508562] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6401.551972] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6430.179465] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 6472.185310] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6477.270921] Lustre: DEBUG MARKER: osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 3 sec [ 6479.068195] Lustre: Unmounted lustre-client [ 6518.082528] Lustre: DEBUG MARKER: == conf-sanity test 50f: normal statfs one server in down ========================================================== 08:39:16 (1789303156) [ 6552.291152] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6558.471761] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6580.809635] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6610.985751] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6639.890937] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 6682.553243] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6684.169512] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6686.192084] Lustre: lustre-OST0001-osc-ffff889187993000: Connection to lustre-OST0001 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 6695.508354] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 6705.868652] Lustre: Unmounted lustre-client [ 6759.296626] Lustre: DEBUG MARKER: == conf-sanity test 50g: deactivated OST should not cause panic ========================================================== 08:43:18 (1789303398) [ 6788.935987] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6793.998495] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6814.430930] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6815.207535] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 6835.810956] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 6837.296906] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 6854.019923] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state (FULL|IDLE) osc.lustre-OST0001-osc-ffff889198dd2000.ost_server_uuid 50 [ 6856.234058] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-ffff889198dd2000.ost_server_uuid in IDLE state after 0 sec [ 6859.629250] Lustre: Unmounted lustre-client [ 6859.896322] Lustre: setting import lustre-OST0001_UUID INACTIVE by administrator request [ 6859.908609] Lustre: Skipped 3 previous similar messages [ 6860.006747] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 6861.305907] LustreError: 149498:0:(sec.c:403:import_sec_validate_get()) import 000000002a03851a (NEW) with no sec [ 6913.524667] Lustre: DEBUG MARKER: == conf-sanity test 50h: LU-642: activate deactivated OST ========================================================== 08:45:52 (1789303552) [ 6949.692647] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 6954.630724] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 6977.185959] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7000.043171] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7000.787746] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [ 7000.939711] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 7010.983216] Lustre: Unmounted lustre-client [ 7010.986768] Lustre: Skipped 1 previous similar message [ 7046.892807] Key type lgssc unregistered [ 7047.110717] LNet: 152897:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7047.114575] LNetError: 152897:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7047.129937] LNet: Removed LNI 192.168.202.38@tcp [ 7047.836281] Key type .llcrypt unregistered [ 7047.840285] Key type ._llcrypt unregistered [ 7064.640717] Key type ._llcrypt registered [ 7064.642166] Key type .llcrypt registered [ 7065.978964] Lustre: DEBUG MARKER: == conf-sanity test 50i: activate deactivated MDT ======== 08:48:24 (1789303704) [ 7067.434647] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7067.464813] alg: No test for adler32 (adler32-zlib) [ 7068.581563] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 7068.879442] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 7070.671168] Key type lgssc registered [ 7072.115376] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7122.294270] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7127.627938] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7147.139862] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7169.124211] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7170.635569] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7171.907204] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 7177.748930] LustreError: lustre-MDT0001-mdc-ffff8891892c3000: This client was evicted by lustre-MDT0001; in progress operations using this service will fail. [ 7177.769648] Lustre: lustre-MDT0001-mdc-ffff8891892c3000: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 7183.628524] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7185.988679] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 7211.530846] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [ 7222.019773] Lustre: Unmounted lustre-client [ 7251.740540] Lustre: DEBUG MARKER: == conf-sanity test 51: Verify that mdt_reint handles RMF_MDT_MD correctly when an OST is added ========================================================== 08:51:30 (1789303890) [ 7347.219199] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7352.753722] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7376.603114] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7377.245597] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 7405.767975] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7408.054185] Lustre: DEBUG MARKER: osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid in FULL state after 0 sec [ 7421.757363] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [ 7432.080158] Lustre: Unmounted lustre-client [ 7467.386549] Key type lgssc unregistered [ 7467.635521] LNet: 162494:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7467.649473] LNetError: 162494:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7467.672603] LNet: Removed LNI 192.168.202.38@tcp [ 7468.292542] Key type .llcrypt unregistered [ 7468.293995] Key type ._llcrypt unregistered [ 7501.030299] Key type ._llcrypt registered [ 7501.035584] Key type .llcrypt registered [ 7502.582649] Lustre: DEBUG MARKER: == conf-sanity test 52: check recovering objects from lost+found ========================================================== 08:55:41 (1789304141) [ 7505.881919] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7505.960906] alg: No test for adler32 (adler32-zlib) [ 7507.225489] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 7507.619979] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 7509.423373] Key type lgssc registered [ 7510.520817] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7560.997383] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7567.179220] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7590.027391] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7592.668563] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 7640.371208] Lustre: Unmounted lustre-client [ 7681.832374] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7682.402142] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 7719.557264] Lustre: Unmounted lustre-client [ 7747.883705] Key type lgssc unregistered [ 7748.192737] LNet: 166937:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7748.201573] LNetError: 166937:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7748.227849] LNet: Removed LNI 192.168.202.38@tcp [ 7749.345748] Key type .llcrypt unregistered [ 7749.349795] Key type ._llcrypt unregistered [ 7765.913389] Key type ._llcrypt registered [ 7765.916447] Key type .llcrypt registered [ 7767.008436] Lustre: DEBUG MARKER: == conf-sanity test 53a: check OSS thread count params === 09:00:06 (1789304406) [ 7769.569241] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 7769.588800] alg: No test for adler32 (adler32-zlib) [ 7770.638140] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 7770.882535] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 7772.567187] Key type lgssc registered [ 7773.723478] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7817.350234] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7821.534421] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7840.341860] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7843.209566] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 7860.533525] Lustre: Unmounted lustre-client [ 7886.194640] Key type lgssc unregistered [ 7886.570808] LNet: 170693:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 7886.576169] LNetError: 170693:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 7886.606842] LNet: Removed LNI 192.168.202.38@tcp [ 7887.438688] Key type .llcrypt unregistered [ 7887.446867] Key type ._llcrypt unregistered [ 7900.005338] Key type ._llcrypt registered [ 7900.010126] Key type .llcrypt registered [ 7900.658360] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 7900.674746] alg: No test for adler32 (adler32-zlib) [ 7901.804238] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 7902.068878] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 7903.760569] Key type lgssc registered [ 7905.134633] Lustre: Echo OBD driver; http://www.lustre.org/ [ 7954.660825] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 7960.261968] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 7982.068562] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 7985.016459] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 7992.297348] Lustre: Unmounted lustre-client [ 8019.006888] Key type lgssc unregistered [ 8019.315538] LNet: 173753:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8019.344289] LNetError: 173753:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8019.379146] LNet: Removed LNI 192.168.202.38@tcp [ 8020.195538] Key type .llcrypt unregistered [ 8020.200559] Key type ._llcrypt unregistered [ 8036.500948] Key type ._llcrypt registered [ 8036.503063] Key type .llcrypt registered [ 8037.729577] Lustre: DEBUG MARKER: == conf-sanity test 53b: check MDS thread count params === 09:04:36 (1789304676) [ 8039.972829] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8039.986902] alg: No test for adler32 (adler32-zlib) [ 8040.990913] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 8041.219284] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 8042.935237] Key type lgssc registered [ 8044.045358] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8092.144261] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8097.914611] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8118.642992] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8120.328922] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 8138.115461] Lustre: Unmounted lustre-client [ 8166.023604] Key type lgssc unregistered [ 8166.477112] LNet: 177498:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8166.528919] LNetError: 177498:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8166.547234] LNet: Removed LNI 192.168.202.38@tcp [ 8167.389957] Key type .llcrypt unregistered [ 8167.394371] Key type ._llcrypt unregistered [ 8180.759266] Key type ._llcrypt registered [ 8180.765224] Key type .llcrypt registered [ 8181.510699] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [ 8181.572225] alg: No test for adler32 (adler32-zlib) [ 8182.772713] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 8183.269867] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 8185.039327] Key type lgssc registered [ 8186.388304] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8239.321813] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8245.527796] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8266.280708] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8268.122912] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 8277.900704] Lustre: Unmounted lustre-client [ 8304.534595] Key type lgssc unregistered [ 8304.774947] LNet: 180556:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8304.786610] LNetError: 180556:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8304.804419] LNet: Removed LNI 192.168.202.38@tcp [ 8305.459348] Key type .llcrypt unregistered [ 8305.461900] Key type ._llcrypt unregistered [ 8320.955781] Key type ._llcrypt registered [ 8320.961906] Key type .llcrypt registered [ 8322.205780] Lustre: DEBUG MARKER: == conf-sanity test 54a: test llverdev and partial verify of device ========================================================== 09:09:21 (1789304961) [ 8344.021748] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8344.054647] alg: No test for adler32 (adler32-zlib) [ 8345.137750] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 8345.475959] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 8347.153158] Key type lgssc registered [ 8348.376544] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8427.767176] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8433.986777] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8456.090914] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8503.043094] Lustre: DEBUG MARKER: == conf-sanity test 54b: test llverfs and partial verify of filesystem ========================================================== 09:12:22 (1789305142) [ 8537.209131] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8542.099253] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8559.710047] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8562.193109] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 8566.402481] Lustre: Unmounted lustre-client [ 8598.002735] Key type lgssc unregistered [ 8598.232736] LNet: 187644:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 8598.239734] LNetError: 187644:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 8599.273652] LNet: Removed LNI 192.168.202.38@tcp [ 8599.851880] Key type .llcrypt unregistered [ 8599.853579] Key type ._llcrypt unregistered [ 8615.274665] Key type ._llcrypt registered [ 8615.277311] Key type .llcrypt registered [ 8616.399437] Lustre: DEBUG MARKER: SKIP: conf-sanity test_55 skipping excluded test 55 [ 8617.715604] Lustre: DEBUG MARKER: == conf-sanity test 56a: check big OST indexes and out-of-index-order start ========================================================== 09:14:17 (1789305257) [ 8635.207975] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 8635.242020] alg: No test for adler32 (adler32-zlib) [ 8636.270424] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 8636.498334] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 8638.143222] Key type lgssc registered [ 8639.113973] Lustre: Echo OBD driver; http://www.lustre.org/ [ 8719.035929] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8724.365532] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8743.900408] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST2710-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8761.497150] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST03e8-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8763.005049] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 8781.410371] Lustre: Unmounted lustre-client [ 8900.519892] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 8906.008755] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 8924.224387] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 8960.977193] Lustre: DEBUG MARKER: == conf-sanity test 56b: test target_obd correctness with nonconsecutive MDTs ========================================================== 09:20:00 (1789305600) [ 8962.431913] Lustre: DEBUG MARKER: SKIP: conf-sanity test_56b needs >= 3 MDTs [ 8964.098498] Lustre: DEBUG MARKER: == conf-sanity test 57a: initial registration from failnode should fail (should return errs) ========================================================== 09:20:03 (1789305603) [ 9043.523348] Key type lgssc unregistered [ 9043.737650] LNet: 199065:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9043.742362] LNetError: 199065:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9043.757134] LNet: Removed LNI 192.168.202.38@tcp [ 9044.308966] Key type .llcrypt unregistered [ 9044.311838] Key type ._llcrypt unregistered [ 9057.381421] Key type ._llcrypt registered [ 9057.383835] Key type .llcrypt registered [ 9058.456450] Lustre: DEBUG MARKER: == conf-sanity test 57b: initial registration from servicenode should not fail ========================================================== 09:21:37 (1789305697) [ 9095.105387] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9095.190365] alg: No test for adler32 (adler32-zlib) [ 9096.238563] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 9096.446983] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 9098.103187] Key type lgssc registered [ 9099.139985] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9136.226571] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9141.914099] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9172.766928] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9196.276734] Key type lgssc unregistered [ 9196.471648] LNet: 202788:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9196.477860] LNetError: 202788:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9196.488043] LNet: Removed LNI 192.168.202.38@tcp [ 9196.995296] Key type .llcrypt unregistered [ 9196.997569] Key type ._llcrypt unregistered [ 9208.559608] Key type ._llcrypt registered [ 9208.563238] Key type .llcrypt registered [ 9209.635295] Lustre: DEBUG MARKER: == conf-sanity test 58: missing llog files must not prevent MDT from mounting ========================================================== 09:24:08 (1789305848) [ 9212.179678] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9212.195486] alg: No test for adler32 (adler32-zlib) [ 9213.156397] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 9213.415350] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 9215.111292] Key type lgssc registered [ 9215.952549] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9257.149904] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9261.106314] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9279.908462] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9286.693201] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 9291.754373] Lustre: lustre-MDT0000-mdc-ffff8891984a8000: Connection to lustre-MDT0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9296.868497] Lustre: lustre-MDT0001-mdc-ffff8891984a8000: Connection to lustre-MDT0001 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9313.247278] Lustre: 203773:0:(client.c:2503:ptlrpc_expire_one_request()) @@@ Request sent has timed out for slow reply: [sent 1789305937/real 1789305937] req@00000000839a8eec x1876223174197120/t0(0) o400->MGC192.168.202.138@tcp@192.168.202.138@tcp:26/25 lens 224/224 e 0 to 1 dl 1789305953 ref 1 fl Rpc:XNQr/200/ffffffff rc 0/-1 job:'' uid:0 gid:0 projid:4294967295 [ 9313.274171] LustreError: MGC192.168.202.138@tcp: Connection to MGS (at 192.168.202.138@tcp) was lost; in progress operations using this service will fail [ 9323.558652] Lustre: Evicted from MGS (at 192.168.202.138@tcp) after server handle changed from 0xaaab8ccc63cef3ff to 0xaaab8ccc63cf0eee [ 9323.574770] Lustre: MGC192.168.202.138@tcp: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 9337.837236] LustreError: lustre-MDT0000-mdc-ffff8891984a8000: This client was evicted by lustre-MDT0000; in progress operations using this service will fail. [ 9337.879554] Lustre: lustre-MDT0000-mdc-ffff8891984a8000: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 9339.188970] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9340.098861] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9343.917474] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9344.998217] Lustre: DEBUG MARKER: mdc.lustre-MDT0001-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9346.784078] Lustre: Unmounted lustre-client [ 9377.738164] Key type lgssc unregistered [ 9377.943262] LNet: 207728:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9377.948222] LNetError: 207728:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9377.970429] LNet: Removed LNI 192.168.202.38@tcp [ 9378.440842] Key type .llcrypt unregistered [ 9378.442938] Key type ._llcrypt unregistered [ 9387.739103] Key type ._llcrypt registered [ 9387.741214] Key type .llcrypt registered [ 9388.650599] Lustre: DEBUG MARKER: == conf-sanity test 59: writeconf mount option =========== 09:27:08 (1789306028) [ 9390.391319] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9390.479815] alg: No test for adler32 (adler32-zlib) [ 9391.477551] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 9391.648964] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 9393.319192] Key type lgssc registered [ 9394.109216] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9431.107818] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9435.565876] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9474.255385] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9477.727924] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9502.171519] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9516.133636] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9563.608877] Key type lgssc unregistered [ 9563.771360] LNet: 213009:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9563.777344] LNetError: 213009:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9563.797653] LNet: Removed LNI 192.168.202.38@tcp [ 9564.206823] Key type .llcrypt unregistered [ 9564.209409] Key type ._llcrypt unregistered [ 9594.338326] Key type ._llcrypt registered [ 9594.339596] Key type .llcrypt registered [ 9595.113326] Lustre: DEBUG MARKER: == conf-sanity test 60a: check mkfs.lustre --mkfsoptions -E -O options setting ========================================================== 09:30:34 (1789306234) [ 9620.052516] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9620.093909] alg: No test for adler32 (adler32-zlib) [ 9621.096836] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 9621.291306] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 9622.911575] Key type lgssc registered [ 9623.569708] Lustre: Echo OBD driver; http://www.lustre.org/ [ 9679.104726] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9683.359725] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9699.904645] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9741.270490] Lustre: DEBUG MARKER: == conf-sanity test 60b: check mkfs.lustre MDT default features ========================================================== 09:33:00 (1789306380) [ 9746.000573] Lustre: DEBUG MARKER: == conf-sanity test 61a: large xattr ===================== 09:33:05 (1789306385) [ 9769.002986] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9772.688742] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9787.651536] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9799.694333] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 9803.956276] Lustre: DEBUG MARKER: save large xattr of 65536 bytes on trusted.big on /mnt/lustre/f61a.conf-sanity [ 9805.682407] Lustre: DEBUG MARKER: shrink value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9806.654926] Lustre: DEBUG MARKER: grow value of trusted.big on /mnt/lustre/f61a.conf-sanity [ 9807.805485] Lustre: DEBUG MARKER: check value of trusted.big on /mnt/lustre/f61a.conf-sanity after remounting MDS [ 9809.893646] Lustre: lustre-MDT0000-mdc-ffff8891846f9000: Connection to lustre-MDT0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9825.257996] LustreError: MGC192.168.202.138@tcp: Connection to MGS (at 192.168.202.138@tcp) was lost; in progress operations using this service will fail [ 9825.275947] Lustre: Evicted from MGS (at 192.168.202.138@tcp) after server handle changed from 0x17ebc9a92a59c654 to 0x17ebc9a92a59c8ca [ 9825.282339] Lustre: MGC192.168.202.138@tcp: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 9829.975709] Lustre: lustre-MDT0000-mdc-ffff8891846f9000: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 9833.521393] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9834.532783] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9837.236837] Lustre: DEBUG MARKER: remove large xattr trusted.big from /mnt/lustre/f61a.conf-sanity [ 9840.612880] Lustre: lustre-MDT0000-mdc-ffff8891846f9000: Connection to lustre-MDT0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [ 9855.979814] LustreError: MGC192.168.202.138@tcp: Connection to MGS (at 192.168.202.138@tcp) was lost; in progress operations using this service will fail [ 9856.000559] Lustre: Evicted from MGS (at 192.168.202.138@tcp) after server handle changed from 0x17ebc9a92a59c8ca to 0x17ebc9a92a59cbda [ 9856.010895] Lustre: MGC192.168.202.138@tcp: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 9860.698397] Lustre: lustre-MDT0000-mdc-ffff8891846f9000: Connection restored to 192.168.202.138@tcp (at 192.168.202.138@tcp) [ 9864.330647] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9865.363650] Lustre: DEBUG MARKER: mdc.lustre-MDT0000-mdc-*.mds_server_uuid in FULL state after 0 sec [ 9868.198506] Lustre: Unmounted lustre-client [ 9920.128324] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [ 9923.969816] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [ 9939.303131] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [ 9950.227855] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [ 9951.367264] Lustre: Unmounted lustre-client [ 9969.234154] Key type lgssc unregistered [ 9969.406881] LNet: 225461:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 9969.411899] LNetError: 225461:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [ 9969.428129] LNet: Removed LNI 192.168.202.38@tcp [ 9969.893761] Key type .llcrypt unregistered [ 9969.895374] Key type ._llcrypt unregistered [ 9977.940542] Key type ._llcrypt registered [ 9977.941723] Key type .llcrypt registered [ 9978.765365] Lustre: DEBUG MARKER: == conf-sanity test 61b: large xattr ===================== 09:36:58 (1789306618) [ 9981.113086] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 9981.120569] alg: No test for adler32 (adler32-zlib) [ 9982.062538] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [ 9982.235907] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [ 9983.871186] Key type lgssc registered [ 9984.584468] Lustre: Echo OBD driver; http://www.lustre.org/ [10011.447255] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10014.163553] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10024.223328] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10025.596277] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [10038.848300] Lustre: Unmounted lustre-client [10083.064374] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10086.391224] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10097.788368] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10098.217526] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [10105.069452] Lustre: Unmounted lustre-client [10152.851019] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10156.594335] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10169.680505] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10170.050782] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [10171.027339] Lustre: Unmounted lustre-client [10191.289899] Key type lgssc unregistered [10191.433669] LNet: 232479:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10191.438460] LNetError: 232479:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10191.453454] LNet: Removed LNI 192.168.202.38@tcp [10191.819762] Key type .llcrypt unregistered [10191.821648] Key type ._llcrypt unregistered [10200.305068] Key type ._llcrypt registered [10200.306757] Key type .llcrypt registered [10201.084765] Lustre: DEBUG MARKER: == conf-sanity test 62: start with disabled journal ====== 09:40:40 (1789306840) [10203.114800] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10203.127099] alg: No test for adler32 (adler32-zlib) [10204.062955] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [10204.217433] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [10205.839491] Key type lgssc registered [10206.474573] Lustre: Echo OBD driver; http://www.lustre.org/ [10229.009688] Key type lgssc unregistered [10229.163678] LNet: 234791:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10229.167378] LNetError: 234791:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10229.184263] LNet: Removed LNI 192.168.202.38@tcp [10229.481760] Key type .llcrypt unregistered [10229.484379] Key type ._llcrypt unregistered [10241.691520] Key type ._llcrypt registered [10241.693154] Key type .llcrypt registered [10241.868201] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10241.876496] alg: No test for adler32 (adler32-zlib) [10242.761187] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [10242.853511] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [10244.447185] Key type lgssc registered [10245.017675] Lustre: Echo OBD driver; http://www.lustre.org/ [10285.786347] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10288.602485] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10300.436940] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10334.736740] Lustre: DEBUG MARKER: SKIP: conf-sanity test_63 skipping excluded test 63 [10335.555258] Lustre: DEBUG MARKER: == conf-sanity test 64: check lfs df --lazy ============== 09:42:55 (1789306975) [10351.503424] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10354.503583] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10364.690962] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10377.140316] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0001-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10378.542346] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [10383.846973] Lustre: lustre-OST0001-osc-ffff8891846fa800: Connection to lustre-OST0001 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [10387.886703] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [10398.220667] Lustre: Unmounted lustre-client [10424.135878] Key type lgssc unregistered [10424.280111] LNet: 241873:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10424.286531] LNetError: 241873:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10424.300314] LNet: Removed LNI 192.168.202.38@tcp [10424.654932] Key type .llcrypt unregistered [10424.656352] Key type ._llcrypt unregistered [10438.449946] Key type ._llcrypt registered [10438.451012] Key type .llcrypt registered [10439.025732] Lustre: DEBUG MARKER: == conf-sanity test 65: re-create the lost last_rcvd file when server mount ========================================================== 09:44:38 (1789307078) [10444.955735] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10445.001366] alg: No test for adler32 (adler32-zlib) [10445.876533] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [10445.986365] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [10447.591174] Key type lgssc registered [10448.069649] Lustre: Echo OBD driver; http://www.lustre.org/ [10473.232893] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10476.326124] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10489.603786] Lustre: DEBUG MARKER: == conf-sanity test 66: replace nids ===================== 09:45:29 (1789307129) [10504.125081] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10506.862894] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10516.030728] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10517.296515] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [10523.128597] Lustre: setting import lustre-OST0000_UUID INACTIVE by administrator request [10524.792397] Lustre: Unmounted lustre-client [10583.142856] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10585.921588] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10623.722847] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10629.115911] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [10629.724171] Lustre: Unmounted lustre-client [10648.938685] Key type lgssc unregistered [10649.080566] LNet: 249554:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10649.086159] LNetError: 249554:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10649.103525] LNet: Removed LNI 192.168.202.38@tcp [10649.426715] Key type .llcrypt unregistered [10649.428260] Key type ._llcrypt unregistered [10661.498035] Key type ._llcrypt registered [10661.500358] Key type .llcrypt registered [10661.680789] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10661.688026] alg: No test for adler32 (adler32-zlib) [10662.624242] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [10662.734627] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [10664.343172] Key type lgssc registered [10664.830044] Lustre: Echo OBD driver; http://www.lustre.org/ [10699.577795] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10702.051106] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10713.561593] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10737.927701] Lustre: DEBUG MARKER: SKIP: conf-sanity test_67 skipping excluded test 67 [10738.667255] Lustre: DEBUG MARKER: == conf-sanity test 68: be able to reserve specific sequences in FLDB ========================================================== 09:49:38 (1789307378) [10752.382217] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10754.518956] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10762.949732] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10769.402583] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [10770.271148] Lustre: Unmounted lustre-client [10788.140549] Key type lgssc unregistered [10788.278700] LNet: 256157:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10788.281631] LNetError: 256157:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10788.290620] LNet: Removed LNI 192.168.202.38@tcp [10788.604782] Key type .llcrypt unregistered [10788.606839] Key type ._llcrypt unregistered [10795.198589] Key type ._llcrypt registered [10795.199731] Key type .llcrypt registered [10795.807472] Lustre: DEBUG MARKER: SKIP: conf-sanity test_69 skipping SLOW test 69 [10796.586586] Lustre: DEBUG MARKER: == conf-sanity test 70a: start MDT0, then OST, then MDT1 ========================================================== 09:50:36 (1789307436) [10800.904995] Key type .llcrypt unregistered [10800.906941] Key type ._llcrypt unregistered [10804.427792] Key type ._llcrypt registered [10804.429923] Key type .llcrypt registered [10804.620762] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [10804.627656] alg: No test for adler32 (adler32-zlib) [10805.521087] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [10805.629502] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [10807.223154] Key type lgssc registered [10807.734359] Lustre: Echo OBD driver; http://www.lustre.org/ [10829.985330] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10841.094063] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [10841.756529] Lustre: Unmounted lustre-client [10859.611213] Key type lgssc unregistered [10859.778741] LNet: 259591:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10859.785470] LNetError: 259591:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10859.794257] LNet: Removed LNI 192.168.202.38@tcp [10860.079151] Key type .llcrypt unregistered [10860.080416] Key type ._llcrypt unregistered [10866.109763] Key type ._llcrypt registered [10866.111080] Key type .llcrypt registered [10866.658775] Lustre: DEBUG MARKER: == conf-sanity test 70b: start OST, MDT1, MDT0 =========== 09:51:46 (1789307506) [10867.585330] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10867.598734] alg: No test for adler32 (adler32-zlib) [10868.480848] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [10868.584519] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [10870.175176] Key type lgssc registered [10870.637696] Lustre: Echo OBD driver; http://www.lustre.org/ [10931.882888] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [10941.678212] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10943.512066] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10945.736125] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [10946.306312] Lustre: Unmounted lustre-client [10963.542655] Key type lgssc unregistered [10963.679502] LNet: 263115:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [10963.681851] LNetError: 263115:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [10963.694819] LNet: Removed LNI 192.168.202.38@tcp [10963.958418] Key type .llcrypt unregistered [10963.960655] Key type ._llcrypt unregistered [10969.472089] Key type ._llcrypt registered [10969.473689] Key type .llcrypt registered [10969.943520] Lustre: DEBUG MARKER: == conf-sanity test 70c: stop MDT0, mkdir fail, create remote dir fail ========================================================== 09:53:29 (1789307609) [10970.752811] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [10970.760972] alg: No test for adler32 (adler32-zlib) [10971.626580] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [10971.726387] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [10973.311173] Key type lgssc registered [10973.692868] Lustre: Echo OBD driver; http://www.lustre.org/ [10991.072201] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [10992.827768] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [10998.986510] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11010.544224] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [11015.652140] Lustre: lustre-MDT0000-mdc-ffff889198dd2000: Connection to lustre-MDT0000 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [11018.225940] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11018.237348] LustreError: 266257:0:(file.c:6167:ll_inode_revalidate_fini()) lustre: revalidate FID [0x200000007:0x1:0x0] error: rc = -108 [11018.357179] LustreError: MGC192.168.202.138@tcp: Connection to MGS (at 192.168.202.138@tcp) was lost; in progress operations using this service will fail [11018.380750] Lustre: Unmounted lustre-client [11029.055084] Key type lgssc unregistered [11029.178373] LNet: 266667:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11029.180793] LNetError: 266667:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11029.188258] LNet: Removed LNI 192.168.202.38@tcp [11029.479459] Key type .llcrypt unregistered [11029.481040] Key type ._llcrypt unregistered [11034.782860] Key type ._llcrypt registered [11034.784081] Key type .llcrypt registered [11035.212698] Lustre: DEBUG MARKER: == conf-sanity test 70d: stop MDT1, mkdir succeed, create remote dir fail ========================================================== 09:54:35 (1789307675) [11035.914727] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11035.923508] alg: No test for adler32 (adler32-zlib) [11036.777487] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [11036.867546] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [11038.455109] Key type lgssc registered [11038.855897] Lustre: Echo OBD driver; http://www.lustre.org/ [11056.563482] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11058.442265] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11064.969595] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11075.569283] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [11080.674039] Lustre: lustre-MDT0001-mdc-ffff889184f36000: Connection to lustre-MDT0001 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [11083.215084] Lustre: setting import lustre-MDT0001_UUID INACTIVE by administrator request [11083.552545] Lustre: Unmounted lustre-client [11094.109892] Key type lgssc unregistered [11094.223825] LNet: 270230:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11094.226143] LNetError: 270230:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11094.232724] LNet: Removed LNI 192.168.202.38@tcp [11094.471119] Key type .llcrypt unregistered [11094.472574] Key type ._llcrypt unregistered [11099.678422] Key type ._llcrypt registered [11099.679525] Key type .llcrypt registered [11100.106268] Lustre: DEBUG MARKER: == conf-sanity test 70e: Sync-on-Cancel will be enabled by default on DNE ========================================================== 09:55:40 (1789307740) [11105.930885] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [11105.939962] alg: No test for adler32 (adler32-zlib) [11106.820992] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [11106.918100] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [11108.511180] Key type lgssc registered [11108.916714] Lustre: Echo OBD driver; http://www.lustre.org/ [11147.000060] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11148.161773] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [11165.154126] Lustre: lustre-MDT0001-mdc-ffff8891892c0800: Connection to lustre-MDT0001 (at 192.168.202.138@tcp) was lost; in progress operations using this service will wait for recovery to complete [11168.579877] Lustre: setting import lustre-MDT0000_UUID INACTIVE by administrator request [11178.874173] Lustre: Unmounted lustre-client [11196.018148] Key type lgssc unregistered [11196.129699] LNet: 275988:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [11196.132763] LNetError: 275988:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [11196.139482] LNet: Removed LNI 192.168.202.38@tcp [11196.391696] Key type .llcrypt unregistered [11196.393125] Key type ._llcrypt unregistered [11202.001042] Key type ._llcrypt registered [11202.002444] Key type .llcrypt registered [11202.502842] Lustre: DEBUG MARKER: == conf-sanity test 71a: start MDT0 OST0, MDT1, OST1 ===== 09:57:22 (1789307842) [11203.088315] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71a needs separate MGS/MDT [11203.715988] Lustre: DEBUG MARKER: == conf-sanity test 71b: start MDT1, OST0, MDT0, OST1 ==== 09:57:23 (1789307843) [11204.288523] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71b needs separate MGS/MDT [11204.857353] Lustre: DEBUG MARKER: == conf-sanity test 71c: start OST0, OST1, MDT1, MDT0 ==== 09:57:24 (1789307844) [11205.461095] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71c needs separate MGS/MDT [11206.080459] Lustre: DEBUG MARKER: == conf-sanity test 71d: start OST0, MDT1, MDT0, OST1 ==== 09:57:25 (1789307845) [11206.645291] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71d needs separate MGS/MDT [11207.248814] Lustre: DEBUG MARKER: == conf-sanity test 71e: start OST0, MDT1, OST1, MDT0 ==== 09:57:27 (1789307847) [11207.793382] Lustre: DEBUG MARKER: SKIP: conf-sanity test_71e needs separate MGS/MDT [11208.369540] Lustre: DEBUG MARKER: == conf-sanity test 72: test fast symlink with extents flag enabled ========================================================== 09:57:28 (1789307848) [11211.590585] Key type .llcrypt unregistered [11211.592080] Key type ._llcrypt unregistered [11214.210405] Key type ._llcrypt registered [11214.216273] Key type .llcrypt registered [11214.332024] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [11214.339380] alg: No test for adler32 (adler32-zlib) [11215.229470] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [11215.334397] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [11216.927152] Key type lgssc registered [11217.346276] Lustre: Echo OBD driver; http://www.lustre.org/ [11245.271361] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11247.327944] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11255.842945] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11257.025918] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [11257.531873] Lustre: Unmounted lustre-client [11280.883453] Lustre: DEBUG MARKER: == conf-sanity test 73a: failnode to update from mountdata properly ========================================================== 09:58:40 (1789307920) [11291.803777] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11293.711822] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11313.808174] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [11334.639821] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [11334.998147] Lustre: Unmounted lustre-client [11364.162519] Lustre: DEBUG MARKER: == conf-sanity test 73b: Large failnode NID list in mountdata ========================================================== 10:00:04 (1789308004) [11364.831412] LNet: 1 local NIs in recovery (showing 1): 192.168.202.38@tcp [11951.904484] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [11953.469271] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [11973.127549] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12019.508518] Lustre: DEBUG MARKER: == conf-sanity test 73c: Server mount doesn't fail with > 32 nets ========================================================== 10:10:59 (1789308659) [12023.306241] Key type lgssc unregistered [12023.426593] LNet: 289489:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12023.428827] LNetError: 289489:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12023.438812] LNet: Removed LNI 192.168.202.38@tcp [12023.691922] Key type .llcrypt unregistered [12023.692908] Key type ._llcrypt unregistered [12101.082516] Key type ._llcrypt registered [12101.083910] Key type .llcrypt registered [12101.222082] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12101.226977] alg: No test for adler32 (adler32-zlib) [12102.083227] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [12102.189262] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [12103.775164] Key type lgssc registered [12104.221654] Lustre: Echo OBD driver; http://www.lustre.org/ [12134.643408] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12136.400429] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12144.493950] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12163.319067] Key type lgssc unregistered [12163.423505] LNet: 293160:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12163.425704] LNetError: 293160:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12163.437436] LNet: Removed LNI 192.168.202.38@tcp [12163.671679] Key type .llcrypt unregistered [12163.672632] Key type ._llcrypt unregistered [12191.612502] Key type ._llcrypt registered [12191.613538] Key type .llcrypt registered [12192.064943] Lustre: DEBUG MARKER: == conf-sanity test 73d: erase + new parameter doesn't corrupt mountdata ========================================================== 10:13:51 (1789308831) [12198.708563] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12198.758182] alg: No test for adler32 (adler32-zlib) [12199.635577] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [12199.742331] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [12201.335179] Key type lgssc registered [12201.759309] Lustre: Echo OBD driver; http://www.lustre.org/ [12218.942638] Lustre: DEBUG MARKER: == conf-sanity test 73e: Mount client with dynamic server NIDs ========================================================== 10:14:18 (1789308858) [12222.902355] Key type lgssc unregistered [12223.024714] LNet: 296701:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12223.027239] LNetError: 296701:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12223.040477] LNet: Removed LNI 192.168.202.38@tcp [12223.280216] Key type .llcrypt unregistered [12223.281822] Key type ._llcrypt unregistered [12226.831392] Key type ._llcrypt registered [12226.833085] Key type .llcrypt registered [12226.969682] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12226.980774] alg: No test for adler32 (adler32-zlib) [12227.839972] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [12227.937094] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [12229.519130] Key type lgssc registered [12229.922902] Lustre: Echo OBD driver; http://www.lustre.org/ [12250.550327] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12252.287669] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12260.022546] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12343.615564] LNet: Added LNI 192.168.202.38@tcp50 [8/256/0/180] [12344.396760] LNet: Removed LNI 192.168.202.38@tcp [12345.773044] Lustre: 301054:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff889198dd3800: config has no valid NIDs, force dynamic NIDs [12346.816840] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [12346.863134] Lustre: Unmounted lustre-client [12347.734448] Key type lgssc unregistered [12347.877156] LNet: 301311:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12347.879344] LNetError: 301311:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12347.889422] LNet: Removed LNI 192.168.202.38@tcp50 [12348.104451] Key type .llcrypt unregistered [12348.105702] Key type ._llcrypt unregistered [12357.959780] Key type ._llcrypt registered [12357.968363] Key type .llcrypt registered [12358.151077] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 2 [12358.155932] alg: No test for adler32 (adler32-zlib) [12359.008465] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [12359.093600] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [12360.679173] Key type lgssc registered [12361.034442] Lustre: Echo OBD driver; http://www.lustre.org/ [12390.051933] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12391.910794] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12394.488360] LNet: Added LNI 192.168.202.38@tcp50 [8/256/0/180] [12394.818759] LNet: Removed LNI 192.168.202.38@tcp [12395.884884] Lustre: 303991:0:(ldlm_lib.c:561:client_obd_setup()) lustre-MDT0000-mdc-ffff889190c3f800: config has no valid NIDs, force dynamic NIDs [12396.933654] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [12397.108214] Lustre: Unmounted lustre-client [12424.297881] Key type lgssc unregistered [12424.451609] LNet: 304860:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12424.455476] LNetError: 304860:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12424.466557] LNet: Removed LNI 192.168.202.38@tcp50 [12424.688526] Key type .llcrypt unregistered [12424.690593] Key type ._llcrypt unregistered [12428.314649] Key type ._llcrypt registered [12428.316281] Key type .llcrypt registered [12428.755841] Lustre: DEBUG MARKER: == conf-sanity test 73f: mgc register before connect ===== 10:17:48 (1789309068) [12434.627859] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12434.671988] alg: No test for adler32 (adler32-zlib) [12435.525809] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [12435.611650] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [12437.199135] Key type lgssc registered [12437.600412] Lustre: Echo OBD driver; http://www.lustre.org/ [12466.391584] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12468.132569] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12476.496454] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12503.555166] Key type lgssc unregistered [12503.694551] LNet: 309588:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12503.697929] LNetError: 309588:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12503.704549] LNet: Removed LNI 192.168.202.38@tcp [12503.950198] Key type .llcrypt unregistered [12503.952177] Key type ._llcrypt unregistered [12507.149781] Key type ._llcrypt registered [12507.151177] Key type .llcrypt registered [12507.624083] Lustre: DEBUG MARKER: == conf-sanity test 74: Test per-device adaptive timeout parameters ========================================================== 10:19:07 (1789309147) [12508.332933] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12508.386784] alg: No test for adler32 (adler32-zlib) [12509.305373] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [12509.429276] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [12511.071213] Key type lgssc registered [12511.693925] Lustre: Echo OBD driver; http://www.lustre.org/ [12551.098280] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12554.770781] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12566.939729] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [12573.754376] Lustre: Mounted lustre-client - version 2.17.57_108_gfed9771 [12610.850960] Lustre: Mounted fs15246-client - version 2.17.57_108_gfed9771 [12626.521888] Lustre: Unmounted fs15246-client [12664.934531] Lustre: Unmounted lustre-client [12710.298633] Key type lgssc unregistered [12710.701423] LNet: 314441:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [12710.713934] LNetError: 314441:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [12710.745922] LNet: Removed LNI 192.168.202.38@tcp [12711.537506] Key type .llcrypt unregistered [12711.539515] Key type ._llcrypt unregistered [12725.566155] Key type ._llcrypt registered [12725.568665] Key type .llcrypt registered [12727.369408] Lustre: DEBUG MARKER: == conf-sanity test 75: The order of --index should be irrelevant ========================================================== 10:22:45 (1789309365) [12729.351545] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [12729.415284] alg: No test for adler32 (adler32-zlib) [12730.430640] Lustre: Lustre: Build Version: 2.17.57_108_gfed9771 [12730.727246] LNet: Added LNI 192.168.202.38@tcp [8/256/0/180] [12732.383201] Key type lgssc registered [12733.609874] Lustre: Echo OBD driver; http://www.lustre.org/ [12873.048873] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid 1475 0 [12879.350719] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid 1475 0 [12905.780919] Lustre: DEBUG MARKER: oleg238-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid 1475 0 [13036.325604] Lustre: DEBUG MARKER: == conf-sanity test complete, duration 12740 sec ========= 10:27:54 (1789309674) [13038.299952] Lustre: DEBUG MARKER: === conf-sanity: start cleanup 10:27:56 (1789309676) === [13043.934185] Lustre: DEBUG MARKER: === conf-sanity: finish cleanup 10:28:01 (1789309681) === [13084.383894] Key type lgssc unregistered [13084.838982] LNet: 323710:0:(lib-ptl.c:964:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [13084.847435] LNetError: 323710:0:(acceptor.c:252:lnet_acceptor_remove_socket()) Interface ens2 not found [13084.873718] LNet: Removed LNI 192.168.202.38@tcp [13085.530359] Key type .llcrypt unregistered [13085.536599] Key type ._llcrypt unregistered